builder: larch_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-007 starttime: 1476726696.15 results: success (0) buildid: 20161017071949 builduid: c3ea6ddaf5b0404faf9955ea1f09d7f5 revision: e7b1b4df6d8b736516cbd0464abeecbc5a2d9018 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 10:51:36.151335) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 10:51:36.151870) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 10:51:36.152182) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 10:51:36.167374) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 10:51:36.167805) ========= 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=923d835db2ba3686ebe126b700000192-1476726695.835542-952862576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-17 10:51:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-10-17 10:51:36 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122930 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 10:51:36.304438) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 10:51:36.304766) ========= 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=923d835db2ba3686ebe126b700000192-1476726695.835542-952862576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015236 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 10:51:36.354730) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 10:51:36.355078) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev e7b1b4df6d8b736516cbd0464abeecbc5a2d9018 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev e7b1b4df6d8b736516cbd0464abeecbc5a2d9018 --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=923d835db2ba3686ebe126b700000192-1476726695.835542-952862576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-17 10:51:36,752 truncating revision to first 12 chars 2016-10-17 10:51:36,752 Setting DEBUG logging. 2016-10-17 10:51:36,752 attempt 1/10 2016-10-17 10:51:36,752 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/e7b1b4df6d8b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-17 10:51:37,052 unpacking tar archive at: larch-e7b1b4df6d8b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.647513 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 10:51:37.016174) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 10:51:37.016493) ========= script_repo_revision: e7b1b4df6d8b736516cbd0464abeecbc5a2d9018 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 10:51:37.016903) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 10:51:37.017166) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 10:51:37.025684) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-17 10:51:37.025991) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Larch-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=923d835db2ba3686ebe126b700000192-1476726695.835542-952862576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:51:37 INFO - MultiFileLogger online at 20161017 10:51:37 in /builds/slave/test 10:51:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO 10:51:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:51:37 INFO - {'append_to_log': False, 10:51:37 INFO - 'base_work_dir': '/builds/slave/test', 10:51:37 INFO - 'blob_upload_branch': 'Larch-Non-PGO', 10:51:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:51:37 INFO - 'branch': 'Larch-Non-PGO', 10:51:37 INFO - 'buildbot_json_path': 'buildprops.json', 10:51:37 INFO - 'config_files': ('talos/linux_config.py',), 10:51:37 INFO - 'default_actions': ('clobber', 10:51:37 INFO - 'read-buildbot-config', 10:51:37 INFO - 'download-and-extract', 10:51:37 INFO - 'populate-webroot', 10:51:37 INFO - 'create-virtualenv', 10:51:37 INFO - 'install', 10:51:37 INFO - 'run-tests'), 10:51:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:51:37 INFO - 'download_minidump_stackwalk': True, 10:51:37 INFO - 'download_symbols': 'ondemand', 10:51:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:51:37 INFO - 'tooltool.py': '/tools/tooltool.py', 10:51:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:51:37 INFO - '/tools/misc-python/virtualenv.py')}, 10:51:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:51:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:51:37 INFO - 'installer_path': 'installer.exe', 10:51:37 INFO - 'log_level': 'info', 10:51:37 INFO - 'log_name': 'talos', 10:51:37 INFO - 'log_to_console': True, 10:51:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:51:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:51:37 INFO - 'opt_config_files': (), 10:51:37 INFO - 'pip_index': False, 10:51:37 INFO - 'sps_profile': False, 10:51:37 INFO - 'sps_profile_interval': 0, 10:51:37 INFO - 'suite': 'dromaeojs', 10:51:37 INFO - 'system_bits': '32', 10:51:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:51:37 INFO - 'title': 'talos-linux64-ix-007', 10:51:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:51:37 INFO - 'use_talos_json': True, 10:51:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:51:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:51:37 INFO - 'work_dir': 'build'} 10:51:37 INFO - [mozharness: 2016-10-17 17:51:37.509754Z] Running clobber step. 10:51:37 INFO - Running pre-action listener: _resource_record_pre_action 10:51:37 INFO - Running main action method: clobber 10:51:37 INFO - rmtree: /builds/slave/test/build 10:51:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:51:38 INFO - Running post-action listener: _resource_record_post_action 10:51:38 INFO - [mozharness: 2016-10-17 17:51:38.007409Z] Finished clobber step (success) 10:51:38 INFO - [mozharness: 2016-10-17 17:51:38.007509Z] Running read-buildbot-config step. 10:51:38 INFO - Running pre-action listener: _resource_record_pre_action 10:51:38 INFO - Running main action method: read_buildbot_config 10:51:38 INFO - Using buildbot properties: 10:51:38 INFO - { 10:51:38 INFO - "project": "", 10:51:38 INFO - "product": "firefox", 10:51:38 INFO - "script_repo_revision": "production", 10:51:38 INFO - "builddir": "larch_ubuntu64_hw_test-dromaeojs", 10:51:38 INFO - "repository": "", 10:51:38 INFO - "buildername": "Ubuntu HW 12.04 x64 larch talos dromaeojs", 10:51:38 INFO - "buildid": "20161017071949", 10:51:38 INFO - "pgo_build": "False", 10:51:38 INFO - "basedir": "/builds/slave/test", 10:51:38 INFO - "buildnumber": 0, 10:51:38 INFO - "slavename": "talos-linux64-ix-007", 10:51:38 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:51:38 INFO - "platform": "ubuntu64_hw", 10:51:38 INFO - "scheduler": "tests-larch-linux64-talos", 10:51:38 INFO - "branch": "larch", 10:51:38 INFO - "repo_path": "projects/larch", 10:51:38 INFO - "revision": "e7b1b4df6d8b736516cbd0464abeecbc5a2d9018", 10:51:38 INFO - "stage_platform": "linux64", 10:51:38 INFO - "builduid": "c3ea6ddaf5b0404faf9955ea1f09d7f5", 10:51:38 INFO - "slavebuilddir": "test" 10:51:38 INFO - } 10:51:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/P26QQXgPT32SB9NToImvPA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 10:51:38 INFO - Running post-action listener: _resource_record_post_action 10:51:38 INFO - [mozharness: 2016-10-17 17:51:38.010085Z] Finished read-buildbot-config step (success) 10:51:38 INFO - [mozharness: 2016-10-17 17:51:38.010173Z] Running download-and-extract step. 10:51:38 INFO - Running pre-action listener: _resource_record_pre_action 10:51:38 INFO - Running main action method: download_and_extract 10:51:38 INFO - mkdir: /builds/slave/test/build/tests 10:51:38 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')]} 10:51:38 INFO - trying https://queue.taskcluster.net/v1/task/P26QQXgPT32SB9NToImvPA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:51:38 INFO - Downloading https://queue.taskcluster.net/v1/task/P26QQXgPT32SB9NToImvPA/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 10:51:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P26QQXgPT32SB9NToImvPA/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 10:51:38 INFO - Downloaded 1361 bytes. 10:51:38 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:51:38 INFO - Using the following test package requirements: 10:51:38 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:51:38 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:51:38 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:51:38 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:51:38 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:51:38 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:51:38 INFO - u'jsshell-linux-x86_64.zip'], 10:51:38 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:51:38 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:51:38 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:51:38 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:51:38 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:51:38 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:51:38 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:51:38 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:51:38 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:51:38 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:51:38 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:51:38 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:51:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P26QQXgPT32SB9NToImvPA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:51:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P26QQXgPT32SB9NToImvPA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:51:38 INFO - Fetch https://queue.taskcluster.net/v1/task/P26QQXgPT32SB9NToImvPA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:51:39 INFO - Http code: 200 10:51:39 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 10:51:39 INFO - x-amz-cf-id: SBH5IW7bbtsCB-8QAtoGWpbIxrlcNc_WKTQE0mSsTGZsSdAXKKNX6w== 10:51:39 INFO - x-amz-version-id: wvezcXwlbE2fTSpakASDKbinMud4fyaW 10:51:39 INFO - Expected file size: 20528584 10:51:39 INFO - Obtained file size: 20528584 10:51:43 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 10:51:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P26QQXgPT32SB9NToImvPA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:51:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P26QQXgPT32SB9NToImvPA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:51:43 INFO - Fetch https://queue.taskcluster.net/v1/task/P26QQXgPT32SB9NToImvPA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:51:44 INFO - Http code: 200 10:51:44 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 10:51:44 INFO - x-amz-cf-id: cAPG2RyKI1YVPJdXb9o2wQgLG9n0z_uadUD17cP8_iOrLl7Knf6C6Q== 10:51:44 INFO - x-amz-version-id: wvezcXwlbE2fTSpakASDKbinMud4fyaW 10:51:44 INFO - Expected file size: 20528584 10:51:44 INFO - Obtained file size: 20528584 10:51:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P26QQXgPT32SB9NToImvPA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 10:51:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P26QQXgPT32SB9NToImvPA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:51:48 INFO - Fetch https://queue.taskcluster.net/v1/task/P26QQXgPT32SB9NToImvPA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 10:51:49 INFO - Http code: 200 10:51:49 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 10:51:49 INFO - x-amz-cf-id: PfxLIQS13U-K37xppk-yt8UQNMb1tCKNwAe0Dtg2zd5jdOPNWO5-AQ== 10:51:49 INFO - x-amz-version-id: jYckp4sosqZ294DzqUq9gI0DtJ0.XUkE 10:51:49 INFO - Expected file size: 14409006 10:51:49 INFO - Obtained file size: 14409006 10:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:49 INFO - trying https://queue.taskcluster.net/v1/task/P26QQXgPT32SB9NToImvPA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:51:49 INFO - Downloading https://queue.taskcluster.net/v1/task/P26QQXgPT32SB9NToImvPA/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 10:51:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P26QQXgPT32SB9NToImvPA/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 10:51:50 INFO - Downloaded 56013616 bytes. 10:51:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P26QQXgPT32SB9NToImvPA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:51:50 INFO - mkdir: /builds/slave/test/properties 10:51:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:51:50 INFO - Writing to file /builds/slave/test/properties/build_url 10:51:50 INFO - Contents: 10:51:50 INFO - build_url:https://queue.taskcluster.net/v1/task/P26QQXgPT32SB9NToImvPA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:51:51 INFO - Running post-action listener: _resource_record_post_action 10:51:51 INFO - Running post-action listener: set_extra_try_arguments 10:51:51 INFO - [mozharness: 2016-10-17 17:51:51.646058Z] Finished download-and-extract step (success) 10:51:51 INFO - [mozharness: 2016-10-17 17:51:51.646283Z] Running populate-webroot step. 10:51:51 INFO - Running pre-action listener: _resource_record_pre_action 10:51:51 INFO - Running main action method: populate_webroot 10:51:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:51:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:51:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:51:51 INFO - '--tppagecycles', 10:51:51 INFO - '7'], 10:51:51 INFO - 'tests': ['tsvgm']}}, 10:51:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:51:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:51:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:51:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:51:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:51:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:51:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:51 INFO - 'talos_options': ['--disable-e10s'], 10:51:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:51:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:51:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:51 INFO - 'talos_options': ['--disable-e10s'], 10:51:51 INFO - 'tests': ['damp', 'tps']}, 10:51:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:51 INFO - 'tests': ['damp', 'tps']}, 10:51:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:51:51 INFO - 'tests': ['dromaeo_dom']}, 10:51:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:51:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:51:51 INFO - 'tests': ['basic_compositor_video']}, 10:51:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:51:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:51:51 INFO - 'tests': ['a11yr', 10:51:51 INFO - 'ts_paint', 10:51:51 INFO - 'tpaint', 10:51:51 INFO - 'sessionrestore', 10:51:51 INFO - 'sessionrestore_no_auto_restore', 10:51:51 INFO - 'tabpaint']}, 10:51:51 INFO - 'other-e10s': {'tests': ['a11yr', 10:51:51 INFO - 'ts_paint', 10:51:51 INFO - 'tpaint', 10:51:51 INFO - 'sessionrestore', 10:51:51 INFO - 'sessionrestore_no_auto_restore', 10:51:51 INFO - 'tabpaint']}, 10:51:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:51:51 INFO - 'ts_paint', 10:51:51 INFO - 'tpaint', 10:51:51 INFO - 'sessionrestore', 10:51:51 INFO - 'sessionrestore_no_auto_restore', 10:51:51 INFO - 'tabpaint']}, 10:51:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:51:51 INFO - 'ts_paint', 10:51:51 INFO - 'tpaint', 10:51:51 INFO - 'sessionrestore', 10:51:51 INFO - 'sessionrestore_no_auto_restore', 10:51:51 INFO - 'tabpaint']}, 10:51:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:51:51 INFO - 'tests': ['a11yr', 10:51:51 INFO - 'ts_paint', 10:51:51 INFO - 'tpaint', 10:51:51 INFO - 'sessionrestore', 10:51:51 INFO - 'sessionrestore_no_auto_restore', 10:51:51 INFO - 'tabpaint']}, 10:51:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:51:51 INFO - 'tests': ['a11yr', 10:51:51 INFO - 'ts_paint', 10:51:51 INFO - 'tpaint', 10:51:51 INFO - 'sessionrestore', 10:51:51 INFO - 'sessionrestore_no_auto_restore', 10:51:51 INFO - 'tabpaint']}, 10:51:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:51:51 INFO - 'tests': ['tsvgx', 10:51:51 INFO - 'tsvgr_opacity', 10:51:51 INFO - 'tart', 10:51:51 INFO - 'tscrollx', 10:51:51 INFO - 'cart']}, 10:51:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:51:51 INFO - 'tsvgr_opacity', 10:51:51 INFO - 'tart', 10:51:51 INFO - 'tscrollx', 10:51:51 INFO - 'cart']}, 10:51:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:51 INFO - 'talos_options': ['--disable-e10s'], 10:51:51 INFO - 'tests': ['tp5o']}, 10:51:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:51 INFO - 'tests': ['tp5o']}, 10:51:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:51 INFO - 'talos_options': ['--disable-e10s', 10:51:51 INFO - '--xperf_path', 10:51:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:51:51 INFO - 'tests': ['tp5n']}, 10:51:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:51 INFO - 'talos_options': ['--xperf_path', 10:51:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:51:51 INFO - 'tests': ['tp5n']}}, 10:51:51 INFO - 'talos.zip': {'path': '', 10:51:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:51:51 INFO - Running post-action listener: _resource_record_post_action 10:51:51 INFO - [mozharness: 2016-10-17 17:51:51.664137Z] Finished populate-webroot step (success) 10:51:51 INFO - [mozharness: 2016-10-17 17:51:51.664225Z] Running create-virtualenv step. 10:51:51 INFO - Running pre-action listener: _resource_record_pre_action 10:51:51 INFO - Running main action method: create_virtualenv 10:51:51 INFO - Creating virtualenv /builds/slave/test/build/venv 10:51:51 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 10:51:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:51:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:51:51 INFO - Using real prefix '/usr' 10:51:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:51:52 INFO - Installing distribute.............................................................................................................................................................................................done. 10:51:54 INFO - Installing pip.................done. 10:51:54 INFO - Return code: 0 10:51:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:51:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:51:54 INFO - Reading from file tmpfile_stdout 10:51:54 INFO - Output received: 10:51:54 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) 10:51:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:51: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')]} 10:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51: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')]} 10:51:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:54 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 0x7fad06cb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cf60>, '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 0x100dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e1d0>, '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': '923d835db2ba3686ebe126b700000192-1476726695.835542-952862576', '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 10:51:54 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 10:51:54 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 10:51:54 INFO - Using env: {'DISPLAY': ':0', 10:51:54 INFO - 'HOME': '/home/cltbld', 10:51:54 INFO - 'LANG': 'en_US.UTF-8', 10:51:54 INFO - 'LANGUAGE': 'en_US:en', 10:51:54 INFO - 'LOGNAME': 'cltbld', 10:51:54 INFO - 'MAIL': '/var/mail/cltbld', 10:51:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:54 INFO - 'MOZ_NO_REMOTE': '1', 10:51:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:54 INFO - 'NO_EM_RESTART': '1', 10:51:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:54 INFO - 'PWD': '/builds/slave/test', 10:51:54 INFO - 'SHELL': '/bin/bash', 10:51:54 INFO - 'SHLVL': '1', 10:51:54 INFO - 'TERM': 'linux', 10:51:54 INFO - 'TMOUT': '86400', 10:51:54 INFO - 'USER': 'cltbld', 10:51:54 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476726695.835542-952862576', 10:51:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:54 INFO - '_': '/tools/buildbot/bin/python'} 10:51:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:54 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 10:51:54 INFO - Cleaning up... 10:51:54 INFO - Return code: 0 10:51:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:51: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')]} 10:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51: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')]} 10:51:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:54 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 0x7fad06cb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cf60>, '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 0x100dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e1d0>, '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': '923d835db2ba3686ebe126b700000192-1476726695.835542-952862576', '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 10:51:54 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 10:51:54 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 10:51:54 INFO - Using env: {'DISPLAY': ':0', 10:51:54 INFO - 'HOME': '/home/cltbld', 10:51:54 INFO - 'LANG': 'en_US.UTF-8', 10:51:54 INFO - 'LANGUAGE': 'en_US:en', 10:51:54 INFO - 'LOGNAME': 'cltbld', 10:51:54 INFO - 'MAIL': '/var/mail/cltbld', 10:51:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:54 INFO - 'MOZ_NO_REMOTE': '1', 10:51:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:54 INFO - 'NO_EM_RESTART': '1', 10:51:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:54 INFO - 'PWD': '/builds/slave/test', 10:51:54 INFO - 'SHELL': '/bin/bash', 10:51:54 INFO - 'SHLVL': '1', 10:51:54 INFO - 'TERM': 'linux', 10:51:54 INFO - 'TMOUT': '86400', 10:51:54 INFO - 'USER': 'cltbld', 10:51:54 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476726695.835542-952862576', 10:51:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:54 INFO - '_': '/tools/buildbot/bin/python'} 10:51:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:54 INFO - Downloading/unpacking psutil>=3.1.1 10:51:54 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 10:51:54 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 10:51:54 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 10:51:54 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 10:51:54 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 10:51:54 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 10:51:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:51:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:51:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:51:56 INFO - Installing collected packages: psutil 10:51:56 INFO - Running setup.py install for psutil 10:51:56 INFO - building 'psutil._psutil_linux' extension 10:51:56 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 10:51:57 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 10:51:57 INFO - building 'psutil._psutil_posix' extension 10:51:57 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 10:51:57 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 10:51:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:51:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:51:57 INFO - Successfully installed psutil 10:51:57 INFO - Cleaning up... 10:51:57 INFO - Return code: 0 10:51:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:51:57 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')]} 10:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:57 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')]} 10:51:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:57 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 0x7fad06cb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cf60>, '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 0x100dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e1d0>, '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': '923d835db2ba3686ebe126b700000192-1476726695.835542-952862576', '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 10:51:57 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 10:51:57 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 10:51:57 INFO - Using env: {'DISPLAY': ':0', 10:51:57 INFO - 'HOME': '/home/cltbld', 10:51:57 INFO - 'LANG': 'en_US.UTF-8', 10:51:57 INFO - 'LANGUAGE': 'en_US:en', 10:51:57 INFO - 'LOGNAME': 'cltbld', 10:51:57 INFO - 'MAIL': '/var/mail/cltbld', 10:51:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:57 INFO - 'MOZ_NO_REMOTE': '1', 10:51:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:57 INFO - 'NO_EM_RESTART': '1', 10:51:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:57 INFO - 'PWD': '/builds/slave/test', 10:51:57 INFO - 'SHELL': '/bin/bash', 10:51:57 INFO - 'SHLVL': '1', 10:51:57 INFO - 'TERM': 'linux', 10:51:57 INFO - 'TMOUT': '86400', 10:51:57 INFO - 'USER': 'cltbld', 10:51:57 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476726695.835542-952862576', 10:51:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:57 INFO - '_': '/tools/buildbot/bin/python'} 10:51:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:51:57 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 10:51:57 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 10:51:57 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 10:51:57 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 10:51:57 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 10:51:57 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 10:51:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:51:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:51:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:51:59 INFO - Installing collected packages: mozsystemmonitor 10:51:59 INFO - Running setup.py install for mozsystemmonitor 10:51:59 INFO - Successfully installed mozsystemmonitor 10:51:59 INFO - Cleaning up... 10:51:59 INFO - Return code: 0 10:51:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:59 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 0x7fad06cb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cf60>, '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 0x100dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e1d0>, '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': '923d835db2ba3686ebe126b700000192-1476726695.835542-952862576', '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 10:51:59 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 10:51:59 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 10:51:59 INFO - Using env: {'DISPLAY': ':0', 10:51:59 INFO - 'HOME': '/home/cltbld', 10:51:59 INFO - 'LANG': 'en_US.UTF-8', 10:51:59 INFO - 'LANGUAGE': 'en_US:en', 10:51:59 INFO - 'LOGNAME': 'cltbld', 10:51:59 INFO - 'MAIL': '/var/mail/cltbld', 10:51:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:59 INFO - 'MOZ_NO_REMOTE': '1', 10:51:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:59 INFO - 'NO_EM_RESTART': '1', 10:51:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:59 INFO - 'PWD': '/builds/slave/test', 10:51:59 INFO - 'SHELL': '/bin/bash', 10:51:59 INFO - 'SHLVL': '1', 10:51:59 INFO - 'TERM': 'linux', 10:51:59 INFO - 'TMOUT': '86400', 10:51:59 INFO - 'USER': 'cltbld', 10:51:59 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476726695.835542-952862576', 10:51:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:59 INFO - '_': '/tools/buildbot/bin/python'} 10:52:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:00 INFO - Downloading/unpacking jsonschema==2.5.1 10:52:00 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 10:52:00 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 10:52:00 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 10:52:00 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 10:52:00 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 10:52:00 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 10:52:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:52:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:52:01 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 10:52:01 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 10:52:01 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 10:52:01 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 10:52:01 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 10:52:01 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 10:52:02 INFO - Downloading functools32-3.2.3-2.tar.gz 10:52:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:52:02 INFO - warning: no files found matching '*.txt' 10:52:02 INFO - no previously-included directories found matching 'build' 10:52:02 INFO - no previously-included directories found matching 'dist' 10:52:02 INFO - no previously-included directories found matching '.git*' 10:52:02 INFO - Installing collected packages: jsonschema, functools32 10:52:02 INFO - Running setup.py install for functools32 10:52:02 INFO - warning: no files found matching '*.txt' 10:52:02 INFO - no previously-included directories found matching 'build' 10:52:02 INFO - no previously-included directories found matching 'dist' 10:52:02 INFO - no previously-included directories found matching '.git*' 10:52:02 INFO - Successfully installed jsonschema functools32 10:52:02 INFO - Cleaning up... 10:52:02 INFO - Return code: 0 10:52:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:52:02 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')]} 10:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:02 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')]} 10:52:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:02 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 0x7fad06cb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cf60>, '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 0x100dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e1d0>, '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': '923d835db2ba3686ebe126b700000192-1476726695.835542-952862576', '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 10:52:02 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 10:52:02 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 10:52:02 INFO - Using env: {'DISPLAY': ':0', 10:52:02 INFO - 'HOME': '/home/cltbld', 10:52:02 INFO - 'LANG': 'en_US.UTF-8', 10:52:02 INFO - 'LANGUAGE': 'en_US:en', 10:52:02 INFO - 'LOGNAME': 'cltbld', 10:52:02 INFO - 'MAIL': '/var/mail/cltbld', 10:52:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:02 INFO - 'MOZ_NO_REMOTE': '1', 10:52:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:02 INFO - 'NO_EM_RESTART': '1', 10:52:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:02 INFO - 'PWD': '/builds/slave/test', 10:52:02 INFO - 'SHELL': '/bin/bash', 10:52:02 INFO - 'SHLVL': '1', 10:52:02 INFO - 'TERM': 'linux', 10:52:02 INFO - 'TMOUT': '86400', 10:52:02 INFO - 'USER': 'cltbld', 10:52:02 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476726695.835542-952862576', 10:52:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:02 INFO - '_': '/tools/buildbot/bin/python'} 10:52:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:52:02 INFO - Cleaning up... 10:52:02 INFO - Return code: 0 10:52:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:52:02 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')]} 10:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:02 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')]} 10:52:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:02 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 0x7fad06cb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cf60>, '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 0x100dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e1d0>, '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': '923d835db2ba3686ebe126b700000192-1476726695.835542-952862576', '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 10:52:02 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 10:52:02 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 10:52:02 INFO - Using env: {'DISPLAY': ':0', 10:52:02 INFO - 'HOME': '/home/cltbld', 10:52:02 INFO - 'LANG': 'en_US.UTF-8', 10:52:02 INFO - 'LANGUAGE': 'en_US:en', 10:52:02 INFO - 'LOGNAME': 'cltbld', 10:52:02 INFO - 'MAIL': '/var/mail/cltbld', 10:52:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:02 INFO - 'MOZ_NO_REMOTE': '1', 10:52:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:02 INFO - 'NO_EM_RESTART': '1', 10:52:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:02 INFO - 'PWD': '/builds/slave/test', 10:52:02 INFO - 'SHELL': '/bin/bash', 10:52:02 INFO - 'SHLVL': '1', 10:52:02 INFO - 'TERM': 'linux', 10:52:02 INFO - 'TMOUT': '86400', 10:52:02 INFO - 'USER': 'cltbld', 10:52:02 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476726695.835542-952862576', 10:52:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:02 INFO - '_': '/tools/buildbot/bin/python'} 10:52:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:02 INFO - Downloading/unpacking blobuploader==1.2.4 10:52:02 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 10:52:02 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 10:52:02 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 10:52:02 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 10:52:02 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 10:52:02 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 10:52:04 INFO - Downloading blobuploader-1.2.4.tar.gz 10:52:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:52:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:52:04 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 10:52:04 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 10:52:04 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 10:52:04 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 10:52:04 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 10:52:04 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 10:52:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:52:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:05 INFO - Downloading docopt-0.6.1.tar.gz 10:52:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:52:05 INFO - Installing collected packages: blobuploader, requests, docopt 10:52:05 INFO - Running setup.py install for blobuploader 10:52:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:52:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:52:05 INFO - Running setup.py install for requests 10:52:06 INFO - Running setup.py install for docopt 10:52:06 INFO - Successfully installed blobuploader requests docopt 10:52:06 INFO - Cleaning up... 10:52:06 INFO - Return code: 0 10:52:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:52:06 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')]} 10:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:06 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')]} 10:52:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:06 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 0x7fad06cb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cf60>, '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 0x100dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e1d0>, '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': '923d835db2ba3686ebe126b700000192-1476726695.835542-952862576', '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 10:52:06 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 10:52:06 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 10:52:06 INFO - Using env: {'DISPLAY': ':0', 10:52:06 INFO - 'HOME': '/home/cltbld', 10:52:06 INFO - 'LANG': 'en_US.UTF-8', 10:52:06 INFO - 'LANGUAGE': 'en_US:en', 10:52:06 INFO - 'LOGNAME': 'cltbld', 10:52:06 INFO - 'MAIL': '/var/mail/cltbld', 10:52:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:06 INFO - 'MOZ_NO_REMOTE': '1', 10:52:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:06 INFO - 'NO_EM_RESTART': '1', 10:52:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:06 INFO - 'PWD': '/builds/slave/test', 10:52:06 INFO - 'SHELL': '/bin/bash', 10:52:06 INFO - 'SHLVL': '1', 10:52:06 INFO - 'TERM': 'linux', 10:52:06 INFO - 'TMOUT': '86400', 10:52:06 INFO - 'USER': 'cltbld', 10:52:06 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476726695.835542-952862576', 10:52:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:06 INFO - '_': '/tools/buildbot/bin/python'} 10:52:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:52:06 INFO - Running setup.py (path:/tmp/pip-IU3Qpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:52:06 INFO - Running setup.py (path:/tmp/pip-SzeJ9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:52:06 INFO - Running setup.py (path:/tmp/pip-dl3OQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:52:06 INFO - Running setup.py (path:/tmp/pip-3OT4LL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:52:06 INFO - Running setup.py (path:/tmp/pip-4OI5K8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:52:06 INFO - Running setup.py (path:/tmp/pip-11tb2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:52:06 INFO - Running setup.py (path:/tmp/pip-x3hudt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:52:06 INFO - Running setup.py (path:/tmp/pip-m12wOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:52:06 INFO - Running setup.py (path:/tmp/pip-R7vOS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:52:07 INFO - Running setup.py (path:/tmp/pip-PjNzsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:52:07 INFO - Running setup.py (path:/tmp/pip-ZPe6Ld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:52:07 INFO - Running setup.py (path:/tmp/pip-Ke7RbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:52:07 INFO - Running setup.py (path:/tmp/pip-5pu5as-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:52:07 INFO - Running setup.py (path:/tmp/pip-yWhZ_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:07 INFO - Running setup.py (path:/tmp/pip-YiKb92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:52:07 INFO - Running setup.py (path:/tmp/pip-Vpi9G_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:52:07 INFO - Running setup.py (path:/tmp/pip-Q10vGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:52:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:52:07 INFO - Running setup.py install for manifestparser 10:52:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:52:07 INFO - Running setup.py install for mozcrash 10:52:07 INFO - Running setup.py install for mozdebug 10:52:07 INFO - Running setup.py install for mozdevice 10:52:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:52:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:52:08 INFO - Running setup.py install for mozfile 10:52:08 INFO - Running setup.py install for mozhttpd 10:52:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:52:08 INFO - Running setup.py install for mozinfo 10:52:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:52:08 INFO - Running setup.py install for mozInstall 10:52:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:52:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:52:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:52:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:52:08 INFO - Running setup.py install for mozleak 10:52:08 INFO - Running setup.py install for mozlog 10:52:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:52:08 INFO - Running setup.py install for moznetwork 10:52:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:52:08 INFO - Running setup.py install for mozprocess 10:52:08 INFO - Running setup.py install for mozprofile 10:52:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:52:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:52:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:52:09 INFO - Running setup.py install for mozrunner 10:52:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:52:09 INFO - Running setup.py install for mozscreenshot 10:52:09 INFO - Running setup.py install for moztest 10:52:09 INFO - Running setup.py install for mozversion 10:52:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:52:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:52:09 INFO - Cleaning up... 10:52:09 INFO - Return code: 0 10:52:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:52:09 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')]} 10:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:09 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')]} 10:52:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:09 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 0x7fad06cb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cf60>, '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 0x100dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e1d0>, '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': '923d835db2ba3686ebe126b700000192-1476726695.835542-952862576', '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 10:52:09 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 10:52:09 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 10:52:09 INFO - Using env: {'DISPLAY': ':0', 10:52:09 INFO - 'HOME': '/home/cltbld', 10:52:09 INFO - 'LANG': 'en_US.UTF-8', 10:52:09 INFO - 'LANGUAGE': 'en_US:en', 10:52:09 INFO - 'LOGNAME': 'cltbld', 10:52:09 INFO - 'MAIL': '/var/mail/cltbld', 10:52:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:09 INFO - 'MOZ_NO_REMOTE': '1', 10:52:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:09 INFO - 'NO_EM_RESTART': '1', 10:52:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:09 INFO - 'PWD': '/builds/slave/test', 10:52:09 INFO - 'SHELL': '/bin/bash', 10:52:09 INFO - 'SHLVL': '1', 10:52:09 INFO - 'TERM': 'linux', 10:52:09 INFO - 'TMOUT': '86400', 10:52:09 INFO - 'USER': 'cltbld', 10:52:09 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476726695.835542-952862576', 10:52:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:09 INFO - '_': '/tools/buildbot/bin/python'} 10:52:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:52:09 INFO - Running setup.py (path:/tmp/pip-OeyaBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:52:09 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)) 10:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:52:09 INFO - Running setup.py (path:/tmp/pip-eJ_KYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:52:09 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)) 10:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:52:09 INFO - Running setup.py (path:/tmp/pip-bUNexP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:52:09 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)) 10:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:52:09 INFO - Running setup.py (path:/tmp/pip-DP27rk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:52:09 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)) 10:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:52:09 INFO - Running setup.py (path:/tmp/pip-cRv62M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:52:10 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)) 10:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:52:10 INFO - Running setup.py (path:/tmp/pip-pIyrzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:52:10 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)) 10:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:52:10 INFO - Running setup.py (path:/tmp/pip-i7vsrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:52:10 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)) 10:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:52:10 INFO - Running setup.py (path:/tmp/pip-LwXoHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:52:10 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)) 10:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:52:10 INFO - Running setup.py (path:/tmp/pip-qXXjRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:52:10 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)) 10:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:52:10 INFO - Running setup.py (path:/tmp/pip-QpVEqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:52:10 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)) 10:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:52:10 INFO - Running setup.py (path:/tmp/pip-Cvh902-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:52:10 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)) 10:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:52:10 INFO - Running setup.py (path:/tmp/pip-EK9Ihd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:52:10 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)) 10:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:52:10 INFO - Running setup.py (path:/tmp/pip-bYSjC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:52:10 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)) 10:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:52:10 INFO - Running setup.py (path:/tmp/pip-DImT_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:52:10 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)) 10:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:10 INFO - Running setup.py (path:/tmp/pip-ea_OPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:10 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)) 10:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:52:10 INFO - Running setup.py (path:/tmp/pip-6w9akQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:52:10 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)) 10:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:52:10 INFO - Running setup.py (path:/tmp/pip-JOBfRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:52:10 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)) 10:52:10 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)) 10:52:10 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)) 10:52:10 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)) 10:52:10 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)) 10:52:10 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)) 10:52:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:12 INFO - Downloading blessings-1.6.tar.gz 10:52:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:52:12 INFO - Installing collected packages: blessings 10:52:12 INFO - Running setup.py install for blessings 10:52:13 INFO - Successfully installed blessings 10:52:13 INFO - Cleaning up... 10:52:13 INFO - Return code: 0 10:52:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:52:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:52:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:52:13 INFO - Reading from file tmpfile_stdout 10:52:13 INFO - Current package versions: 10:52:13 INFO - argparse == 1.2.1 10:52:13 INFO - blessings == 1.6 10:52:13 INFO - blobuploader == 1.2.4 10:52:13 INFO - docopt == 0.6.1 10:52:13 INFO - functools32 == 3.2.3-2 10:52:13 INFO - jsonschema == 2.5.1 10:52:13 INFO - manifestparser == 1.1 10:52:13 INFO - mozInstall == 1.12 10:52:13 INFO - mozcrash == 0.17 10:52:13 INFO - mozdebug == 0.1 10:52:13 INFO - mozdevice == 0.48 10:52:13 INFO - mozfile == 1.2 10:52:13 INFO - mozhttpd == 0.7 10:52:13 INFO - mozinfo == 0.9 10:52:13 INFO - mozleak == 0.1 10:52:13 INFO - mozlog == 3.4 10:52:13 INFO - moznetwork == 0.27 10:52:13 INFO - mozprocess == 0.23 10:52:13 INFO - mozprofile == 0.28 10:52:13 INFO - mozrunner == 6.12 10:52:13 INFO - mozscreenshot == 0.1 10:52:13 INFO - mozsystemmonitor == 0.3 10:52:13 INFO - moztest == 0.7 10:52:13 INFO - mozversion == 1.4 10:52:13 INFO - psutil == 3.1.1 10:52:13 INFO - requests == 1.2.3 10:52:13 INFO - wsgiref == 0.1.2 10:52:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:52:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:13 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 0x7fad06cb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cf60>, '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 0x100dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e1d0>, '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': '923d835db2ba3686ebe126b700000192-1476726695.835542-952862576', '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 10:52:13 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 10:52:13 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 10:52:13 INFO - Using env: {'DISPLAY': ':0', 10:52:13 INFO - 'HOME': '/home/cltbld', 10:52:13 INFO - 'LANG': 'en_US.UTF-8', 10:52:13 INFO - 'LANGUAGE': 'en_US:en', 10:52:13 INFO - 'LOGNAME': 'cltbld', 10:52:13 INFO - 'MAIL': '/var/mail/cltbld', 10:52:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:13 INFO - 'MOZ_NO_REMOTE': '1', 10:52:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:13 INFO - 'NO_EM_RESTART': '1', 10:52:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:13 INFO - 'PWD': '/builds/slave/test', 10:52:13 INFO - 'SHELL': '/bin/bash', 10:52:13 INFO - 'SHLVL': '1', 10:52:13 INFO - 'TERM': 'linux', 10:52:13 INFO - 'TMOUT': '86400', 10:52:13 INFO - 'USER': 'cltbld', 10:52:13 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476726695.835542-952862576', 10:52:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:13 INFO - '_': '/tools/buildbot/bin/python'} 10:52:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:13 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)) 10:52:13 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)) 10:52:13 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)) 10:52:13 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)) 10:52:13 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)) 10:52:13 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)) 10:52:13 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)) 10:52:13 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)) 10:52:13 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)) 10:52:13 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)) 10:52:13 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)) 10:52:13 INFO - Cleaning up... 10:52:13 INFO - Return code: 0 10:52:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:52:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:52:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad06cb3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100cf60>, '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 0x100dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e1d0>, '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': '923d835db2ba3686ebe126b700000192-1476726695.835542-952862576', '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 10:52:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:52:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:52:13 INFO - Using env: {'DISPLAY': ':0', 10:52:13 INFO - 'HOME': '/home/cltbld', 10:52:13 INFO - 'LANG': 'en_US.UTF-8', 10:52:13 INFO - 'LANGUAGE': 'en_US:en', 10:52:13 INFO - 'LOGNAME': 'cltbld', 10:52:13 INFO - 'MAIL': '/var/mail/cltbld', 10:52:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:13 INFO - 'MOZ_NO_REMOTE': '1', 10:52:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:13 INFO - 'NO_EM_RESTART': '1', 10:52:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:13 INFO - 'PWD': '/builds/slave/test', 10:52:13 INFO - 'SHELL': '/bin/bash', 10:52:13 INFO - 'SHLVL': '1', 10:52:13 INFO - 'TERM': 'linux', 10:52:13 INFO - 'TMOUT': '86400', 10:52:13 INFO - 'USER': 'cltbld', 10:52:13 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476726695.835542-952862576', 10:52:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:13 INFO - '_': '/tools/buildbot/bin/python'} 10:52:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:52:13 INFO - Cleaning up... 10:52:13 INFO - Return code: 0 10:52:13 INFO - Running post-action listener: _resource_record_post_action 10:52:13 INFO - Running post-action listener: _start_resource_monitoring 10:52:13 INFO - Starting resource monitoring. 10:52:13 INFO - [mozharness: 2016-10-17 17:52:13.798028Z] Finished create-virtualenv step (success) 10:52:13 INFO - [mozharness: 2016-10-17 17:52:13.798493Z] Running install step. 10:52:13 INFO - Running pre-action listener: _resource_record_pre_action 10:52:13 INFO - Running main action method: install 10:52:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:52:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:52:14 INFO - Reading from file tmpfile_stdout 10:52:14 INFO - Detecting whether we're running mozinstall >=1.0... 10:52:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:52:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:52:14 INFO - Reading from file tmpfile_stdout 10:52:14 INFO - Output received: 10:52:14 INFO - Usage: mozinstall [options] installer 10:52:14 INFO - Options: 10:52:14 INFO - -h, --help show this help message and exit 10:52:14 INFO - -d DEST, --destination=DEST 10:52:14 INFO - Directory to install application into. [default: 10:52:14 INFO - "/builds/slave/test"] 10:52:14 INFO - --app=APP Application being installed. [default: firefox] 10:52:14 INFO - mkdir: /builds/slave/test/build/application 10:52:14 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'] 10:52:14 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 10:52:30 INFO - Reading from file tmpfile_stdout 10:52:30 INFO - Output received: 10:52:30 INFO - /builds/slave/test/build/application/firefox/firefox 10:52:30 INFO - Running post-action listener: _resource_record_post_action 10:52:30 INFO - [mozharness: 2016-10-17 17:52:30.277820Z] Finished install step (success) 10:52:30 INFO - [mozharness: 2016-10-17 17:52:30.278064Z] Running run-tests step. 10:52:30 INFO - Running pre-action listener: _resource_record_pre_action 10:52:30 INFO - Running main action method: run_tests 10:52:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:52:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:52:30 INFO - Python 2.7.3 10:52:30 INFO - Return code: 0 10:52:30 INFO - grabbing minidump binary from tooltool 10:52:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:30 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 0x100cf60>, '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 0x100dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:52:30 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 10:52:30 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 10:52:30 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 10:52:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:52:30 INFO - Return code: 0 10:52:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:52:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:52:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:52:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:52:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:52:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P26QQXgPT32SB9NToImvPA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:52:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/P26QQXgPT32SB9NToImvPA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:52:30 INFO - Using env: {'DISPLAY': ':0', 10:52:30 INFO - 'HOME': '/home/cltbld', 10:52:30 INFO - 'LANG': 'en_US.UTF-8', 10:52:30 INFO - 'LANGUAGE': 'en_US:en', 10:52:30 INFO - 'LOGNAME': 'cltbld', 10:52:30 INFO - 'MAIL': '/var/mail/cltbld', 10:52:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:52:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:52:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:30 INFO - 'MOZ_NO_REMOTE': '1', 10:52:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:52:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:30 INFO - 'NO_EM_RESTART': '1', 10:52:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:30 INFO - 'PWD': '/builds/slave/test', 10:52:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:52:30 INFO - 'SHELL': '/bin/bash', 10:52:30 INFO - 'SHLVL': '1', 10:52:30 INFO - 'TERM': 'linux', 10:52:30 INFO - 'TMOUT': '86400', 10:52:30 INFO - 'USER': 'cltbld', 10:52:30 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476726695.835542-952862576', 10:52:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:30 INFO - '_': '/tools/buildbot/bin/python'} 10:52:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P26QQXgPT32SB9NToImvPA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:52:30 INFO - mozversion application_buildid: 20161017071949 10:52:30 INFO - mozversion application_changeset: e7b1b4df6d8b736516cbd0464abeecbc5a2d9018 10:52:30 INFO - mozversion application_display_name: Nightly 10:52:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:52:30 INFO - mozversion application_name: Firefox 10:52:30 INFO - mozversion application_remotingname: firefox 10:52:30 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 10:52:30 INFO - mozversion application_vendor: Mozilla 10:52:30 INFO - mozversion application_version: 52.0a1 10:52:30 INFO - mozversion platform_buildid: 20161017071949 10:52:30 INFO - mozversion platform_changeset: e7b1b4df6d8b736516cbd0464abeecbc5a2d9018 10:52:30 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 10:52:30 INFO - mozversion platform_version: 52.0a1 10:52:30 INFO - using testdate: 1476726750 10:52:30 INFO - actual date: 1476726750 10:52:30 INFO - starting webserver on 'localhost:40958' 10:52:30 INFO - SUITE-START | Running 2 tests 10:52:30 INFO - TEST-START | dromaeo_css 10:52:30 INFO - operating with platform_type : linux_ 10:52:30 INFO - Initialising browser for dromaeo_css test... 10:52:30 INFO - TEST-INFO | started process 17355 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuE2D_9/profile http://localhost:40958/getInfo.html) 10:52:34 INFO - PROCESS | 17355 | __metrics Screen width/height:1600/1200 10:52:34 INFO - PROCESS | 17355 | colorDepth:24 10:52:34 INFO - PROCESS | 17355 | Browser inner width/height: 1024/697 10:52:34 INFO - PROCESS | 17355 | __metrics 10:52:35 INFO - PROCESS | 17355 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:52:35 INFO - PROCESS | 17355 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:52:35 INFO - PROCESS | 17355 | console.error: PushService: 10:52:35 INFO - PROCESS | 17355 | stateChangeProcessEnqueue: Error transitioning state 10:52:35 INFO - PROCESS | 17355 | UnknownError 10:52:36 INFO - TEST-INFO | 17355: exit 0 10:52:36 INFO - Browser initialized. 10:52:36 INFO - Running cycle 1/1 for dromaeo_css test... 10:52:36 INFO - TEST-INFO | started process 17441 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuE2D_9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:52:48 INFO - PROCESS | 17441 | RSS: Main: 176795648 10:52:48 INFO - PROCESS | 17441 | 10:53:40 INFO - PROCESS | 17441 | 1476726820319 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] 10:55:53 INFO - PROCESS | 17441 | Cycle 1(1): loaded http://localhost:40958/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40958/tests/dromaeo/cssquery-ext.html) 10:55:55 INFO - PROCESS | 17441 | RSS: Main: 316805120 10:55:55 INFO - PROCESS | 17441 | 10:58:58 INFO - PROCESS | 17441 | Cycle 1(1): loaded http://localhost:40958/tests/dromaeo/cssquery-ext.html (next: http://localhost:40958/tests/dromaeo/cssquery-jquery.html) 10:58:58 INFO - PROCESS | 17441 | RSS: Main: 282087424 10:58:58 INFO - PROCESS | 17441 | 11:02:00 INFO - PROCESS | 17441 | Cycle 1(1): loaded http://localhost:40958/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40958/tests/dromaeo/cssquery-mootools.html) 11:02:01 INFO - PROCESS | 17441 | RSS: Main: 224440320 11:02:01 INFO - PROCESS | 17441 | 11:05:03 INFO - PROCESS | 17441 | Cycle 1(1): loaded http://localhost:40958/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40958/tests/dromaeo/cssquery-prototype.html) 11:05:04 INFO - PROCESS | 17441 | RSS: Main: 223461376 11:05:04 INFO - PROCESS | 17441 | 11:08:07 INFO - PROCESS | 17441 | Cycle 1(1): loaded http://localhost:40958/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40958/tests/dromaeo/cssquery-yui.html) 11:08:08 INFO - PROCESS | 17441 | RSS: Main: 222351360 11:08:08 INFO - PROCESS | 17441 | 11:11:11 INFO - PROCESS | 17441 | Cycle 1(1): loaded http://localhost:40958/tests/dromaeo/cssquery-yui.html (next: http://localhost:40958/tests/dromaeo/cssquery-dojo.html) 11:11:11 INFO - PROCESS | 17441 | RSS: Main: 315084800 11:11:11 INFO - PROCESS | 17441 | 11:11:11 INFO - PROCESS | 17441 | __start_tp_report 11:11:11 INFO - PROCESS | 17441 | _x_x_mozilla_page_load 11:11:11 INFO - PROCESS | 17441 | _x_x_mozilla_page_load_details 11:11:11 INFO - PROCESS | 17441 | |i|pagename|runs| 11:11:11 INFO - PROCESS | 17441 | |0;dojo.html;2539.454017386262;2562.436264021917;2594.675665541807;2606.661134052573;2615.699194592621;4451;4541.43232095988;4660.4174478190225;4692.953070469299;4699.953000469995;4560.4527456705155;4574.405327307453;4580.198465268573;4583;4584.3352713856475;4176.394422808698;4196.265653510639;4206.095689426773;4231.682623803212;4235.110626768367;4315.633171180438;4333.588309110645;4355.629771469429;4358.150160718661;4362.302031674933;4223.598758117974;4266.701330906838;4286.39990401344;4294.377315289281;4365.476142862861;4338.479382474124;4339.631131353807;4343.457067866517;4372.278574035312;4380.386745855582;3971.920561588781;3988.581198974095;4133.503979522447;4234.280172370704;4256.87229383119;4561;4603.447586289667;4604.930926036079;4606.124836281129;4680.742559159245;4898.779554920037;4900.6569540132205;4919.409670839486;4926.211806111005;4967.329410529568;4866.489018653026;4928.28539861718;4931.4821943696115;4942.728149951751;5009.273655319958;4625.629949604024;4626.421697287839;4629.837955671535;4639.141758774604;4640.930386044212;5056.191009438472;5057.418396884332;5065.3161823153405;5083.466236045236;5089;4820.807167713252;4861.173600487926;4868.975655121772;4875.804967801319;4875.853724388274;4957.578605818474;4962.6774259673;4967.031428871408;4971.676841005323;5032.547070763649;4959.677620954699;5000.699958002531;5052.317937078521;5067.543921047123;5068.062408454448;4983.252512123138;4989.5758860496535;4995.150824359867;4995.850124496271;5039.899202015939;3815.5802861685193;3865.5168103987003;3871.245107204068;3923.6861051115843;3929.410588411704;3391.033555436689;3428.297199074184;3436.2783815398548;3444.983729799715;3507.684308412255;4277.978610106929;4281.97859010703;4283.485981682218;4334.934975975363;4339.500957389878;4735.668503204743;4914.434839993446;4922.975385123052;4940.827071052496;4981.850544483671;4168.333066709312;4214.346776249687;4282.978585107055;4308.224519586442;4338.783060846945;4483.417155769795;4484.75333856641;4490.932636010462;4508.504064552896;4536.4102666653125;4736.763161841825;4750.762461876961;4751.40607424072;4751.976240118777;4807.927881081857;4748.62011039123;4820.855374338776;4831.371921650163;5014.398272207212;5023.572996295356;4601.723896566216;4680.976595117003;4717.103750287434;4723.031778485333;4782.832600859092;4903.117438860897;4905.583025442877;4908.190148625579;4931.580815630568;4969.925451118163;4963.883126296699;4968.205087186033;4969.155243608523;4977.9502204978935;5023.6985780853265;4659.184642687448;4714.269288260325;4795.184818580919;4838.274258861199;4850.151223535797;4816.783244754065;4848.0546293472435;4852.902941941212;4896.045271172087;4906.215005599087;4759.976200118977;4771.665983381269;4801.615870730403;4803.711777293373;4858.392700912386;4757.738324392191;4820.469748327751;4826.469088400203;4876.512348765237;4907.705537667752;4713.128071306819;4751.524847515221;4763.571278584944;4776.904461910812;4777.211760059551 11:11:11 INFO - PROCESS | 17441 | |1;ext.html;556.057482567049;556.379636705074;558.3885645218486;573.9856503587409;578.5718568259488;26709.732902670967;37884.43173352398;39397.212055758864;39506.209875802466;42764.572354276446;40063.39904901429;40368.59631403685;40544.59455405445;40558.18883622326;40601.390979135336;7382.224866389019;7519.586422746746;7525.623718814065;7528.58592777397;7529.47293689442;7587.089549254069;7653.693852245931;7670.539767613961;7673.884891726629;7674.309312161904;7652.464327497078;7697.615119244043;7701.768946931601;7702.383809295271;7703.576303303316;7586.772396828076;7606.733764318277;7615.961920190419;7618.276263754934;7644.044494438195;7451.925480745177;7502.6623801929045;7508.249175082448;7519.13529944058;7526.36025937796;37092.81453592742;37462;37480.62519374826;37498;37509.249815003546;2795.7623601993855;2810.0867218153976;2862.77097832175;2955.9999999999786;3197.232664160608;27493.725062749516;28330.575041374395;28335.291617709518;29137.854310728522;29251.707482925325;3295.8352082395786;3338.7162091222276;3438.2263990601914;3515.0860776198115;3519.6480351964856;171786;172170;278818;286050;288460;50389.496105039216;56302.39917611152;56658;56685.43314566884;56771.14843277354;33812.32375352479;34920;59345.70327148337;60071.39928600746;60277;14193.503227387198;14262.714745705236;14317.64205894861;14380.209088500023;14387.568372948828;11280.548778048951;11338.886611133783;11385.203035787581;11389.088872890148;11403.315801051964;18607;18614.906925465286;18750;18753.24987000532;18790.624187516172;7025.648717564101;7135.857282854314;7286.854262914712;7320.194778574352;7388.261173882569;763.6792547130108;829.6432534010434;880.7621942075604;914.7530166855045;919.7838507950627;26673.466530669666;27279.86360068187;27869.86065069702;28014.579781303295;29992.25019374533;737.5316673912105;859.2536540682619;874.191372979991;900;904.9954750226339;11113.611023614296;13301.135426197266;13889.097208681404;13919.897551460153;14063.2968351582;172735;173697;174221;174683;352439;46608.53391466042;46916.53083469121;46965.29552056722;46981.76509117501;47099;995.5818556206266;1039.656913218636;1123.9494222759995;1178.5268414481898;1178.5544994137028;26655.866720666272;27488.312792180357;28084.578731318637;28307.150785476468;28319.433611327247;40382.596174037884;41045.794771025954;41059.7947010275;41119.177616448105;41170.794146029075;304163;307468;307802;308402;367237;35314;37394.813025934694;38222.42666360062;38732.80633596814;39060.218795624496;37954.81022594869;38566.22867542577;40838.1832363357;41236.58763412447;41591.792041039604;34840.30319393649;35505.46741798927;35610.82194589011;35678;35988.28023439464;35119.47320790139;35679.82160089183;35702.28595428129;35744.28511429705;35764.284714306086;34345.82827085849;34941.47587786135;35166.82416587901;35233.1191720209;35348.646513534535;30408;31648.525272120474;31860.840695796374;32501;32710.50934236036;24563.63154552719;24749.611166697494;24878.37804054913;25026;25398.873005634854 11:11:11 INFO - PROCESS | 17441 | |2;jquery.html;334.0979355739504;344.8896353166987;348.71057022671204;353.6445871898742;366.70113857206377;11872.168948173621;12830.422630981604;15728.685426291482;15952.20238988049;16559.420420285292;16605;16909.23908424121;17033.233504492327;17187.74218386722;17233.31066757328;4596.919723864889;4949.2823540586505;4979.850604481853;5185.585153187736;5188.92216616751;4973.651844370896;5101.489851014888;5105.05556472052;5111.105556527611;5114.514121158484;5074.416442109149;5085.211792172201;5089.4910508949;5096.592272618182;5237.8952420951555;5392.2181283713835;5530.474604912527;5530.5022547970475;5533;5536.363318218416;5265.631405801595;5318.73406329682;5361.061814182542;5371.785128594852;5450.890982180374;19617.21531138753;20091.497712557302;20126.094325755377;20351.389458316273;20399.89800051005;1773.9911300443416;1890.253349926785;1901.591157901044;2061.360978096795;2300.18343488061;8599.63575203268;8668.26319762821;9170.81658366829;9261.675841345588;9270.30472714549;1636.6563021765444;1665.608581983233;1714.8799584029123;1808.3580328983153;1809.1406581873637;67683.66158169178;68210;68749.65625171892;69024.3097569023;69617;9635.710928672152;9817.214622830157;9962.750931226778;10034.197264218845;10104.141148002502;13785.862141378459;13803.17180969145;13819.170849749047;13832.792508112387;13839.962002849625;6966.663578606558;7069.646517674199;7120.679569419389;7300.233475484997;7305.050343455423;6601.702923368364;6657.966710166515;6831.521793474509;6833.897491537631;6872.072270243453;4154.750714957112;4215.852445164466;4240.300350442142;4367.781610919441;4379.386885835986;1748.2395158106265;1784.1703607822426;1801.4325487471403;1812.3747307179003;1829.039754129093;815.1155995744565;826.3802148388709;867.089555966233;902.8600566912139;920.8756817829641;16562.420315288906;16617.584560385847;16621.584460388345;16734.83265167333;17408.303667853397;761.455559275121;793.2384910485998;797.8324551844178;824.6083110522574;871.8910136232971;9083.318751093695;9184.448933064037;9574.95212523933;9644.807103857884;9966.352187107816;395145;398206;439358;444327;450529;65187;73758;77530;78338.60830695811;80027.99790015772;381.6012267180803;397.60835576956674;399.5784447407954;400.50937601438585;401.68668438617925;9826.950865245914;9911.504424778876;9928.453935033642;10077.344972576759;10093;34730;34737.13157171091;35219.47170792492;35996.64003359933;36241.818790905876;47756.5224347766;48170;50668.23997640112;50803.237951431496;51001.83970564692;7605.505642133244;7650.2349765023055;7679.846403071795;7730.381569474541;7840.215978402114;7802.960985195038;9448.622055117718;10641.733956651145;10760.569577216824;11537.07703383744;9174.486209775312;9524.571394287412;9604.135627793532;9721.513924303898;10116.898831011596;9039.186473217442;9139.451632902048;9388.530573471162;9950.800983980134;10309.845352319571;9712.854307185256;9738.561764720745;9866.210703143875;10163.898361016296;10642.574297028032;6935.895961560682;6977.511574189758;7073.115860517435;7191.496595238283;7254.6735396908325;7660.846783064196;9444.291678124306;9497.667581634609;9552.092551207625;9583.233341332816 11:11:11 INFO - PROCESS | 17441 | |3;mootools.html;1128.7178205448638;1291.6125162451265;1330.9733805323895;1345.4887142885702;1633.926473308701;6334.524910631704;7127.928720712791;7352.154502232245;7383.963080184605;7582.393408527319;7407.25927407259;7443.8883416748795;7454.329110380065;7455.62721863906;7471.850562988737;2076.169532187122;2093.288281984125;2113.4399384163207;2114.217739436403;2114.577084583082;2056.4139220322213;2058.9616279882885;2062.669972804352;2089.592529456749;2091.16353458617;2040.4490787487368;2047.0276618606117;2074.3984244569056;2074.9936280903826;2100.0339843671927;2033.5729496805689;2039.2149022626247;2040.55107876267;2042.7650820155723;2051.3538235455785;2046.2838006697536;2062.0308455026266;2069.637813382667;2071;2079.740032495938;7170.533915295541;7215.819604509877;7281.6723247453465;7373.225811289844;7426.962865185694;4197.9370309445385;4364.476262848447;4375.671824613135;4376.081022985177;4377.846775362847;2724.50958827411;2861.3704984903497;2936.236578489587;2940.7500362469214;2944.749696275819;876.5354362188051;885.1281487734576;885.9335549833788;890.559173209259;891.9866202006975;9577.090176433228;9636.95181524095;9646.083622055894;9683.515824208762;9689.660861869801;3638.235970446236;3781.3949768036982;3839.7120215983914;3908.843646254118;3916.8629097981434;7748.070231572247;7764.767056988299;7771.10632277284;7773.106092799288;7777.066751989797;4162.375643653476;4164.208800327989;4166.83332666696;4167.5207351154395;4168.583141685807;3471.8264086795557;3592.407252803258;3828;3828.406596977473;3856.73002889795;3191.5159450855463;3192.6009248843893;3307.9007629771145;3321.8837340692958;3343.3981883261245;958.0946006024241;962.0908241711516;972.776261459854;978.1685567267907;995.1938929467154;729.6023667101442;778.7780482562442;782.9569373684388;795.3676826922494;795.5703919883198;4575.359449677047;4625.213713668684;4673.766311684402;4821.927671084936;4839.540243676845;811.350919264586;821.1829229916272;823.7322870067132;869.2567854484452;870.6473878079388;3076.2770748873995;3087.228192951762;3101.2712012677002;3176.1583180457196;3198.6801319867827;8462.19609137131;8877;8893.28853691703;8904.065073167354;8908.06465321145;8855.822883542422;8863.335249856287;8866.42368246062;8873.689420870238;8876.334274929277;6926.272741362185;7053.612051337123;7064.222935477196;7068.752593659197;7069.469789765788;4536.228841097088;4643.419572553431;4687.2031754602485;4698.577128058354;4733.763311834464;8336.208060234268;8343.916560834314;8346.248837604644;8359.373047021376;8385;8429.325653947546;8451.492910425393;8614.956925215334;8648.697295594624;8662.220400164015;5457.426970168234;5747;5978.790742323998;5990.7903223386975;6000.189974353407;6378.840528986812;6550.967245163934;6551.6069035858;6564.245111812012;6566.8358291043105;6139.109829074849;6308.306086330592;6414.198225221848;6498.512611554058;6586.901196482152;6096.481799046954;6146.754129834757;6215.34738852414;6242;6358.300586935526;5486.753096110605;5625.943740562706;5678.943210568007;5855.414458554111;5937.376575459514;4182.079942412664;4209.915801683888;4210.726302790309;4273.829046838092;4447;4096.201240758142;4138.151678905877;4164.500259968823;4254.51073126582;4418.403515525363 11:11:11 INFO - PROCESS | 17441 | |4;prototype.html;292.2022877544304;301.9969800301996;302.04252519513153;307.20434075743833;313.0764245475847;4682.735661371432;4751.881202969923;4757.643176761744;4768.570828625423;4792.544708252719;4733.704153485557;4741.122892264925;4758.881027974302;4764.857054288377;4770.475247722757;3558.5195998540253;3626.764260323084;3679.5952445231005;3772.7927063339607;3785.9621403786023;3768.5100936878302;3770.001898993538;3773.3208022555928;3773.622637736218;3779.300829346566;3731.533558305212;3737.86917457889;3741.8129093545213;3743.588205297429;3745.494358261627;3558.5018097466377;3661.7916087690996;3669.174435751961;3718.2935242303874;3751.8499260029703;3339.1819004343847;3341.214814518586;3341.677534113792;3349;3350.8492117854753;4656.697314674535;4660.41545874401;4661.230896902007;4662.8134874604975;4668.649851261169;4140.358244472081;4267.978660106711;4280.293751530994;4284.978575107136;4306.428153723899;4953.529414705597;4975.228839529878;4983.152864013126;4989.201727723546;4991.176455884774;3665.486831843544;3679.1537946272238;3682.705383569308;3691.1325838427947;3694.2796154749835;5088;5200.517852412045;5209.661372010807;5239.973800131013;5252.474752524755;3743.9251214975548;3771.2834561433788;3775.2638235544355;3776.3950321113416;3788.981055094762;3822.197338558878;3829.4064420014943;3832.156925476391;3833.923321533554;3854.9229015419533;4313.741175529478;4326.394304797331;4347.717423360116;4354.281543545279;4366.672499562482;4828.758562071883;4999.3000979862845;5017.573506251936;5026.547610715053;5044.2937988681615;1322.3983087695076;1328.2030781531005;1333.2134040915905;1333.8466076401144;1340.3365334159653;823.3865770001267;853.8719192121232;862.8144948835904;866.4151697604092;874.6588830356167;4261.424707664426;4346.413234213404;4427.911441771146;4468.106378724268;4480.798364073559;5113.948860511422;5134.101532231844;5136.897262054738;5140.3550863723995;5155.278261043457;4472.881779555111;4485.932711009337;4486.484054333728;4505.391772110723;4508.594226519629;2628.7108418073994;2717.5787752897936;2736;2738.835669859775;2741.314671332167;4905.901881962341;4907.2393778964315;4909.288153217834;4911.778969946289;4931.457539670633;5055.570276526463;5273.551748101454;5280.524752772269;5283.471652834763;5288.550473209821;4858.663867436412;4866.7566621668775;4877.6585639004925;4883.682560633548;4897.191963326011;5099.515546023122;5116.1581830540235;5119.948800511947;5141.614378921521;5141.742912854267;4849.296851956376;5013.824516142064;5028.547430731252;5057.912548801878;5086.3896332440345;4948.851534453972;4971.726555039363;4979.751012449436;4981.900361992667;4988.900221995613;3629.5825980012637;3652.598214196383;3655.853765849336;3657.2868290684128;3662.230931504307;5100.132977393926;5177.715225662474;5184.559312458332;5219.686818790885;5220.399654039834;5043.394792624908;5066.873328166678;5075.467075956972;5087.23691446286;5090.796368145233;5038.496150384932;5051.646384753032;5053.570446512088;5061.468545802638;5069.7718602662235;4747.691400058985;4977.64009293718;4989.750512474289;5000.874628282892;5014.147594908802;4827.300041493893;4942.627538781333;5054.721990290569;5071.315372424823;5087.949120508895;4820.542048505386;4956.950430495649;4959.11553609626;4965.354503914468;4966.528179822911 11:11:11 INFO - PROCESS | 17441 | |5;yui.html;569.5813577020887;595.8391234366721;616.3128112154949;679.2731776998611;694.5520139510016;12777;13690.589282321545;13692;13698.794518082212;13703.38334774935;12766.872331276685;12919.93540032301;12923.41844616992;12938.805917911239;12949.158304710187;535.2239253083026;548.6351576201841;730.8209488675282;736.6942718771703;758.0978635423855;747.7644541969262;755.3390783064818;756.7275780718965;756.8334966307431;757.3221966340122;790.6521130702502;790.8695065314245;791.0823444804;791.1376599506536;791.9287264146226;567.3673853653147;583.950364219042;762.0702742653954;782.9882551761757;783.7883771381723;574.431313000131;576.9711514424262;579.860833399981;580.8838232353504;581.3866370978658;12571.497140114385;12576.937115314366;12585.24488530691;12593.496260149583;12615.558455454107;11287;11508.13688973322;11563.710907227303;11664;12063.336516491589;11226.796763446024;11440.084793216523;11524.88475115255;11528.250663706833;11594.304341739522;3766.164940590286;3806.847726090953;3899;3979.5423526294558;4027.0335119571387;58183.41816581865;59143.70428147875;60161.398386016015;60891.39108608946;61081.6945915272;9373.109554592304;9555.331126821195;9601.951990240004;9689.854652180082;9765.16996055329;16753.497395078168;17433;17476.126193690263;17821.821781782277;17853.28586856511;6481.222253329631;6566.4418524425;6624.171978502687;6632.237292711304;6709.094272273181;3523.4890940813953;3567.23304489536;3573.6783689468075;3586.8027258501033;3600.261946301002;2809.592609071673;2898.7970842041277;2934.559816027613;2943.2936095336963;2944.573036909679;479.95920346770913;487.9121758083508;491.53549895349266;495.3115169913823;498.09098395428487;520.5029197116744;561.1498579651831;588.0180099234288;601.8525461261931;603.3755063509246;7642.541447513167;7933.761987140279;7971.285799150462;8020.879686804586;8101.513909165469;554.8557375082507;580.2978396140633;582.3797655496883;585.9912101318483;590.8079874040953;3532.717382609385;3865.69074474047;3937.822797974098;3987.4018897165656;4009.3384591542654;93609.53195234116;97738;101082;105288.47355763172;105689.47155264174;87264.56367718248;89253;90824;92352.53823730838;92631;65894.67052664707;74176.25823741693;75137.62431187808;77088.22911770923;78040.60979695065;7360.484766066324;7618.466707330434;7620.8475830484185;7752.573608451589;7820.257075577811;31805.840970794998;40303.79848100858;44622.77688611666;45549.31676024796;46343.76828115838;50854.49145508498;51895;54404.91190176095;58411.4158858406;59428.40571594229;9611;9839.212862970802;9874.111329980336;11092.168087393638;11169.888301116885;12433.254004759743;12539.49842006346;12684.175528590613;13085.345732713136;13437.462501500222;11332.263402878787;11343.149263805082;11570.190086694187;11617.88382116168;12045.277283363026;10110.39337639744;10152.238582106223;10416.583336666448;10490.790184196121;11228.270162439416;11277.830832537682;11359.204855660355;11373.20387572895;11481.827772583585;11568.652940411801;9004.639814407612;9499.905000949902;9563.952180239054;9584.616615335308;9791.559379828068;9049.864252036094;9242.306826988137;9964.202863770735;10000.399976001463;10006.549705263425 11:11:11 INFO - PROCESS | 17441 | __end_tp_report 11:11:11 INFO - PROCESS | 17441 | __start_cc_report 11:11:11 INFO - PROCESS | 17441 | _x_x_mozilla_cycle_collect,1410 11:11:11 INFO - PROCESS | 17441 | __end_cc_report 11:11:11 INFO - PROCESS | 17441 | __startTimestamp1476727871514__endTimestamp 11:11:11 INFO - PROCESS | 17441 | 11:11:11 INFO - PROCESS | 17441 | ------- Summary: start ------- 11:11:11 INFO - PROCESS | 17441 | Number of tests: 6 11:11:11 INFO - PROCESS | 17441 | 11:11:11 INFO - PROCESS | 17441 | [#0] dojo.html Cycles:165 Average:4566.50 Median:4735.67 stddev:507.87 (10.7%) stddev-sans-first:483.89 11:11:11 INFO - PROCESS | 17441 | Values: 2539.5 2562.4 2594.7 2606.7 2615.7 4451.0 4541.4 4660.4 4693.0 4700.0 4560.5 4574.4 4580.2 4583.0 4584.3 4176.4 4196.3 4206.1 4231.7 4235.1 4315.6 4333.6 4355.6 4358.2 4362.3 4223.6 4266.7 4286.4 4294.4 4365.5 4338.5 4339.6 4343.5 4372.3 4380.4 3971.9 3988.6 4133.5 4234.3 4256.9 4561.0 4603.4 4604.9 4606.1 4680.7 4898.8 4900.7 4919.4 4926.2 4967.3 4866.5 4928.3 4931.5 4942.7 5009.3 4625.6 4626.4 4629.8 4639.1 4640.9 5056.2 5057.4 5065.3 5083.5 5089.0 4820.8 4861.2 4869.0 4875.8 4875.9 4957.6 4962.7 4967.0 4971.7 5032.5 4959.7 5000.7 5052.3 5067.5 5068.1 4983.3 4989.6 4995.2 4995.9 5039.9 3815.6 3865.5 3871.2 3923.7 3929.4 3391.0 3428.3 3436.3 3445.0 3507.7 4278.0 4282.0 4283.5 4334.9 4339.5 4735.7 4914.4 4923.0 4940.8 4981.9 4168.3 4214.3 4283.0 4308.2 4338.8 4483.4 4484.8 4490.9 4508.5 4536.4 4736.8 4750.8 4751.4 4752.0 4807.9 4748.6 4820.9 4831.4 5014.4 5023.6 4601.7 4681.0 4717.1 4723.0 4782.8 4903.1 4905.6 4908.2 4931.6 4969.9 4963.9 4968.2 4969.2 4978.0 5023.7 4659.2 4714.3 4795.2 4838.3 4850.2 4816.8 4848.1 4852.9 4896.0 4906.2 4760.0 4771.7 4801.6 4803.7 4858.4 4757.7 4820.5 4826.5 4876.5 4907.7 4713.1 4751.5 4763.6 4776.9 4777.2 11:11:11 INFO - PROCESS | 17441 | 11:11:11 INFO - PROCESS | 17441 | [#1] ext.html Cycles:180 Average:42041.39 Median:35876.28 stddev:69749.84 (194.4%) stddev-sans-first:69875.96 11:11:11 INFO - PROCESS | 17441 | Values: 556.1 556.4 558.4 574.0 578.6 26709.7 37884.4 39397.2 39506.2 42764.6 40063.4 40368.6 40544.6 40558.2 40601.4 7382.2 7519.6 7525.6 7528.6 7529.5 7587.1 7653.7 7670.5 7673.9 7674.3 7652.5 7697.6 7701.8 7702.4 7703.6 7586.8 7606.7 7616.0 7618.3 7644.0 7451.9 7502.7 7508.2 7519.1 7526.4 37092.8 37462.0 37480.6 37498.0 37509.2 2795.8 2810.1 2862.8 2956.0 3197.2 27493.7 28330.6 28335.3 29137.9 29251.7 3295.8 3338.7 3438.2 3515.1 3519.6 171786.0 172170.0 278818.0 286050.0 288460.0 50389.5 56302.4 56658.0 56685.4 56771.1 33812.3 34920.0 59345.7 60071.4 60277.0 14193.5 14262.7 14317.6 14380.2 14387.6 11280.5 11338.9 11385.2 11389.1 11403.3 18607.0 18614.9 18750.0 18753.2 18790.6 7025.6 7135.9 7286.9 7320.2 7388.3 763.7 829.6 880.8 914.8 919.8 26673.5 27279.9 27869.9 28014.6 29992.3 737.5 859.3 874.2 900.0 905.0 11113.6 13301.1 13889.1 13919.9 14063.3 172735.0 173697.0 174221.0 174683.0 352439.0 46608.5 46916.5 46965.3 46981.8 47099.0 995.6 1039.7 1123.9 1178.5 1178.6 26655.9 27488.3 28084.6 28307.2 28319.4 40382.6 41045.8 41059.8 41119.2 41170.8 304163.0 307468.0 307802.0 308402.0 367237.0 35314.0 37394.8 38222.4 38732.8 39060.2 37954.8 38566.2 40838.2 41236.6 41591.8 34840.3 35505.5 35610.8 35678.0 35988.3 35119.5 35679.8 35702.3 35744.3 35764.3 34345.8 34941.5 35166.8 35233.1 35348.6 30408.0 31648.5 31860.8 32501.0 32710.5 24563.6 24749.6 24878.4 25026.0 25398.9 11:11:11 INFO - PROCESS | 17441 | 11:11:11 INFO - PROCESS | 17441 | [#2] jquery.html Cycles:180 Average:24728.12 Median:5108.08 stddev:70174.74 (1373.8%) stddev-sans-first:70347.69 11:11:11 INFO - PROCESS | 17441 | Values: 334.1 344.9 348.7 353.6 366.7 11872.2 12830.4 15728.7 15952.2 16559.4 16605.0 16909.2 17033.2 17187.7 17233.3 4596.9 4949.3 4979.9 5185.6 5188.9 4973.7 5101.5 5105.1 5111.1 5114.5 5074.4 5085.2 5089.5 5096.6 5237.9 5392.2 5530.5 5530.5 5533.0 5536.4 5265.6 5318.7 5361.1 5371.8 5450.9 19617.2 20091.5 20126.1 20351.4 20399.9 1774.0 1890.3 1901.6 2061.4 2300.2 8599.6 8668.3 9170.8 9261.7 9270.3 1636.7 1665.6 1714.9 1808.4 1809.1 67683.7 68210.0 68749.7 69024.3 69617.0 9635.7 9817.2 9962.8 10034.2 10104.1 13785.9 13803.2 13819.2 13832.8 13840.0 6966.7 7069.6 7120.7 7300.2 7305.1 6601.7 6658.0 6831.5 6833.9 6872.1 4154.8 4215.9 4240.3 4367.8 4379.4 1748.2 1784.2 1801.4 1812.4 1829.0 815.1 826.4 867.1 902.9 920.9 16562.4 16617.6 16621.6 16734.8 17408.3 761.5 793.2 797.8 824.6 871.9 9083.3 9184.4 9575.0 9644.8 9966.4 395145.0 398206.0 439358.0 444327.0 450529.0 65187.0 73758.0 77530.0 78338.6 80028.0 381.6 397.6 399.6 400.5 401.7 9827.0 9911.5 9928.5 10077.3 10093.0 34730.0 34737.1 35219.5 35996.6 36241.8 47756.5 48170.0 50668.2 50803.2 51001.8 7605.5 7650.2 7679.8 7730.4 7840.2 7803.0 9448.6 10641.7 10760.6 11537.1 9174.5 9524.6 9604.1 9721.5 10116.9 9039.2 9139.5 9388.5 9950.8 10309.8 9712.9 9738.6 9866.2 10163.9 10642.6 6935.9 6977.5 7073.1 7191.5 7254.7 7660.8 9444.3 9497.7 9552.1 9583.2 11:11:11 INFO - PROCESS | 17441 | 11:11:11 INFO - PROCESS | 17441 | [#3] mootools.html Cycles:180 Average:4720.75 Median:5896.40 stddev:2633.99 (44.7%) stddev-sans-first:2627.54 11:11:11 INFO - PROCESS | 17441 | Values: 1128.7 1291.6 1331.0 1345.5 1633.9 6334.5 7127.9 7352.2 7384.0 7582.4 7407.3 7443.9 7454.3 7455.6 7471.9 2076.2 2093.3 2113.4 2114.2 2114.6 2056.4 2059.0 2062.7 2089.6 2091.2 2040.4 2047.0 2074.4 2075.0 2100.0 2033.6 2039.2 2040.6 2042.8 2051.4 2046.3 2062.0 2069.6 2071.0 2079.7 7170.5 7215.8 7281.7 7373.2 7427.0 4197.9 4364.5 4375.7 4376.1 4377.8 2724.5 2861.4 2936.2 2940.8 2944.7 876.5 885.1 885.9 890.6 892.0 9577.1 9637.0 9646.1 9683.5 9689.7 3638.2 3781.4 3839.7 3908.8 3916.9 7748.1 7764.8 7771.1 7773.1 7777.1 4162.4 4164.2 4166.8 4167.5 4168.6 3471.8 3592.4 3828.0 3828.4 3856.7 3191.5 3192.6 3307.9 3321.9 3343.4 958.1 962.1 972.8 978.2 995.2 729.6 778.8 783.0 795.4 795.6 4575.4 4625.2 4673.8 4821.9 4839.5 811.4 821.2 823.7 869.3 870.6 3076.3 3087.2 3101.3 3176.2 3198.7 8462.2 8877.0 8893.3 8904.1 8908.1 8855.8 8863.3 8866.4 8873.7 8876.3 6926.3 7053.6 7064.2 7068.8 7069.5 4536.2 4643.4 4687.2 4698.6 4733.8 8336.2 8343.9 8346.2 8359.4 8385.0 8429.3 8451.5 8615.0 8648.7 8662.2 5457.4 5747.0 5978.8 5990.8 6000.2 6378.8 6551.0 6551.6 6564.2 6566.8 6139.1 6308.3 6414.2 6498.5 6586.9 6096.5 6146.8 6215.3 6242.0 6358.3 5486.8 5625.9 5678.9 5855.4 5937.4 4182.1 4209.9 4210.7 4273.8 4447.0 4096.2 4138.2 4164.5 4254.5 4418.4 11:11:11 INFO - PROCESS | 17441 | 11:11:11 INFO - PROCESS | 17441 | [#4] prototype.html Cycles:180 Average:4183.96 Median:4758.26 stddev:1203.14 (25.3%) stddev-sans-first:1170.52 11:11:11 INFO - PROCESS | 17441 | Values: 292.2 302.0 302.0 307.2 313.1 4682.7 4751.9 4757.6 4768.6 4792.5 4733.7 4741.1 4758.9 4764.9 4770.5 3558.5 3626.8 3679.6 3772.8 3786.0 3768.5 3770.0 3773.3 3773.6 3779.3 3731.5 3737.9 3741.8 3743.6 3745.5 3558.5 3661.8 3669.2 3718.3 3751.8 3339.2 3341.2 3341.7 3349.0 3350.8 4656.7 4660.4 4661.2 4662.8 4668.6 4140.4 4268.0 4280.3 4285.0 4306.4 4953.5 4975.2 4983.2 4989.2 4991.2 3665.5 3679.2 3682.7 3691.1 3694.3 5088.0 5200.5 5209.7 5240.0 5252.5 3743.9 3771.3 3775.3 3776.4 3789.0 3822.2 3829.4 3832.2 3833.9 3854.9 4313.7 4326.4 4347.7 4354.3 4366.7 4828.8 4999.3 5017.6 5026.5 5044.3 1322.4 1328.2 1333.2 1333.8 1340.3 823.4 853.9 862.8 866.4 874.7 4261.4 4346.4 4427.9 4468.1 4480.8 5113.9 5134.1 5136.9 5140.4 5155.3 4472.9 4485.9 4486.5 4505.4 4508.6 2628.7 2717.6 2736.0 2738.8 2741.3 4905.9 4907.2 4909.3 4911.8 4931.5 5055.6 5273.6 5280.5 5283.5 5288.6 4858.7 4866.8 4877.7 4883.7 4897.2 5099.5 5116.2 5119.9 5141.6 5141.7 4849.3 5013.8 5028.5 5057.9 5086.4 4948.9 4971.7 4979.8 4981.9 4988.9 3629.6 3652.6 3655.9 3657.3 3662.2 5100.1 5177.7 5184.6 5219.7 5220.4 5043.4 5066.9 5075.5 5087.2 5090.8 5038.5 5051.6 5053.6 5061.5 5069.8 4747.7 4977.6 4989.8 5000.9 5014.1 4827.3 4942.6 5054.7 5071.3 5087.9 4820.5 4957.0 4959.1 4965.4 4966.5 11:11:11 INFO - PROCESS | 17441 | 11:11:11 INFO - PROCESS | 17441 | [#5] yui.html Cycles:180 Average:17469.78 Median:27470.07 stddev:25609.48 (93.2%) stddev-sans-first:25649.88 11:11:11 INFO - PROCESS | 17441 | Values: 569.6 595.8 616.3 679.3 694.6 12777.0 13690.6 13692.0 13698.8 13703.4 12766.9 12919.9 12923.4 12938.8 12949.2 535.2 548.6 730.8 736.7 758.1 747.8 755.3 756.7 756.8 757.3 790.7 790.9 791.1 791.1 791.9 567.4 584.0 762.1 783.0 783.8 574.4 577.0 579.9 580.9 581.4 12571.5 12576.9 12585.2 12593.5 12615.6 11287.0 11508.1 11563.7 11664.0 12063.3 11226.8 11440.1 11524.9 11528.3 11594.3 3766.2 3806.8 3899.0 3979.5 4027.0 58183.4 59143.7 60161.4 60891.4 61081.7 9373.1 9555.3 9602.0 9689.9 9765.2 16753.5 17433.0 17476.1 17821.8 17853.3 6481.2 6566.4 6624.2 6632.2 6709.1 3523.5 3567.2 3573.7 3586.8 3600.3 2809.6 2898.8 2934.6 2943.3 2944.6 480.0 487.9 491.5 495.3 498.1 520.5 561.1 588.0 601.9 603.4 7642.5 7933.8 7971.3 8020.9 8101.5 554.9 580.3 582.4 586.0 590.8 3532.7 3865.7 3937.8 3987.4 4009.3 93609.5 97738.0 101082.0 105288.5 105689.5 87264.6 89253.0 90824.0 92352.5 92631.0 65894.7 74176.3 75137.6 77088.2 78040.6 7360.5 7618.5 7620.8 7752.6 7820.3 31805.8 40303.8 44622.8 45549.3 46343.8 50854.5 51895.0 54404.9 58411.4 59428.4 9611.0 9839.2 9874.1 11092.2 11169.9 12433.3 12539.5 12684.2 13085.3 13437.5 11332.3 11343.1 11570.2 11617.9 12045.3 10110.4 10152.2 10416.6 10490.8 11228.3 11277.8 11359.2 11373.2 11481.8 11568.7 9004.6 9499.9 9564.0 9584.6 9791.6 9049.9 9242.3 9964.2 10000.4 10006.5 11:11:11 INFO - PROCESS | 17441 | -------- Summary: end -------- 11:11:11 INFO - PROCESS | 17441 | 11:11:12 INFO - TEST-INFO | 17441: exit 0 11:11:12 INFO - TEST-OK | dromaeo_css | took 1121992ms 11:11:12 INFO - TEST-START | kraken 11:11:12 INFO - operating with platform_type : linux_ 11:11:12 INFO - Initialising browser for kraken test... 11:11:12 INFO - TEST-INFO | started process 17744 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkUJzeu/profile http://localhost:40958/getInfo.html) 11:11:16 INFO - PROCESS | 17744 | __metrics Screen width/height:1600/1200 11:11:16 INFO - PROCESS | 17744 | colorDepth:24 11:11:16 INFO - PROCESS | 17744 | Browser inner width/height: 1024/697 11:11:16 INFO - PROCESS | 17744 | __metrics 11:11:17 INFO - PROCESS | 17744 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:11:17 INFO - PROCESS | 17744 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:11:17 INFO - PROCESS | 17744 | console.error: PushService: 11:11:17 INFO - PROCESS | 17744 | stateChangeProcessEnqueue: Error transitioning state 11:11:17 INFO - PROCESS | 17744 | UnknownError 11:11:18 INFO - TEST-INFO | 17744: exit 0 11:11:18 INFO - Browser initialized. 11:11:18 INFO - Running cycle 1/1 for kraken test... 11:11:18 INFO - TEST-INFO | started process 17827 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkUJzeu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:11:30 INFO - PROCESS | 17827 | RSS: Main: 176271360 11:11:30 INFO - PROCESS | 17827 | 11:11:33 INFO - PROCESS | 17827 | Cycle 1(1): loaded http://localhost:40958/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40958/tests/kraken/driver.html?testName=audio-beat-detection) 11:11:34 INFO - PROCESS | 17827 | RSS: Main: 235302912 11:11:34 INFO - PROCESS | 17827 | 11:11:37 INFO - PROCESS | 17827 | Cycle 1(1): loaded http://localhost:40958/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40958/tests/kraken/driver.html?testName=audio-dft) 11:11:37 INFO - PROCESS | 17827 | RSS: Main: 219865088 11:11:37 INFO - PROCESS | 17827 | 11:11:40 INFO - PROCESS | 17827 | Cycle 1(1): loaded http://localhost:40958/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40958/tests/kraken/driver.html?testName=audio-fft) 11:11:41 INFO - PROCESS | 17827 | RSS: Main: 301674496 11:11:41 INFO - PROCESS | 17827 | 11:11:43 INFO - PROCESS | 17827 | Cycle 1(1): loaded http://localhost:40958/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40958/tests/kraken/driver.html?testName=audio-oscillator) 11:11:44 INFO - PROCESS | 17827 | RSS: Main: 212815872 11:11:44 INFO - PROCESS | 17827 | 11:11:46 INFO - PROCESS | 17827 | Cycle 1(1): loaded http://localhost:40958/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40958/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:11:47 INFO - PROCESS | 17827 | RSS: Main: 215642112 11:11:47 INFO - PROCESS | 17827 | 11:11:50 INFO - PROCESS | 17827 | Cycle 1(1): loaded http://localhost:40958/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40958/tests/kraken/driver.html?testName=imaging-darkroom) 11:11:51 INFO - PROCESS | 17827 | RSS: Main: 252121088 11:11:51 INFO - PROCESS | 17827 | 11:11:54 INFO - PROCESS | 17827 | Cycle 1(1): loaded http://localhost:40958/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40958/tests/kraken/driver.html?testName=imaging-desaturate) 11:11:55 INFO - PROCESS | 17827 | RSS: Main: 251367424 11:11:55 INFO - PROCESS | 17827 | 11:11:58 INFO - PROCESS | 17827 | Cycle 1(1): loaded http://localhost:40958/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40958/tests/kraken/driver.html?testName=json-parse-financial) 11:11:58 INFO - PROCESS | 17827 | RSS: Main: 250601472 11:11:58 INFO - PROCESS | 17827 | 11:12:00 INFO - PROCESS | 17827 | Cycle 1(1): loaded http://localhost:40958/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40958/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:12:00 INFO - PROCESS | 17827 | RSS: Main: 212770816 11:12:00 INFO - PROCESS | 17827 | 11:12:02 INFO - PROCESS | 17827 | Cycle 1(1): loaded http://localhost:40958/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40958/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:12:03 INFO - PROCESS | 17827 | RSS: Main: 220344320 11:12:03 INFO - PROCESS | 17827 | 11:12:05 INFO - PROCESS | 17827 | Cycle 1(1): loaded http://localhost:40958/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40958/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:12:06 INFO - PROCESS | 17827 | RSS: Main: 229560320 11:12:06 INFO - PROCESS | 17827 | 11:12:09 INFO - PROCESS | 17827 | Cycle 1(1): loaded http://localhost:40958/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40958/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:12:09 INFO - PROCESS | 17827 | RSS: Main: 238374912 11:12:09 INFO - PROCESS | 17827 | 11:12:12 INFO - PROCESS | 17827 | Cycle 1(1): loaded http://localhost:40958/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40958/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:12:13 INFO - PROCESS | 17827 | RSS: Main: 234967040 11:12:13 INFO - PROCESS | 17827 | 11:12:15 INFO - PROCESS | 17827 | Cycle 1(1): loaded http://localhost:40958/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40958/tests/kraken/driver.html?testName=ai-astar) 11:12:15 INFO - PROCESS | 17827 | RSS: Main: 283934720 11:12:15 INFO - PROCESS | 17827 | 11:12:15 INFO - PROCESS | 17827 | __start_tp_report 11:12:15 INFO - PROCESS | 17827 | _x_x_mozilla_page_load 11:12:15 INFO - PROCESS | 17827 | _x_x_mozilla_page_load_details 11:12:15 INFO - PROCESS | 17827 | |i|pagename|runs| 11:12:15 INFO - PROCESS | 17827 | |0;ai-astar;111;115;116;114;114;114;113;114;113;114 11:12:15 INFO - PROCESS | 17827 | |1;audio-beat-detection;151;127;129;160;128;131;125;125;159;130 11:12:15 INFO - PROCESS | 17827 | |2;audio-dft;162;161;162;160;163;160;161;160;161;160 11:12:15 INFO - PROCESS | 17827 | |3;audio-fft;77;76;77;109;78;88;76;76;102;76 11:12:15 INFO - PROCESS | 17827 | |4;audio-oscillator;84;84;114;84;84;84;108;85;84;121 11:12:15 INFO - PROCESS | 17827 | |5;imaging-gaussian-blur;117;116;117;117;117;117;116;118;117;117 11:12:15 INFO - PROCESS | 17827 | |6;imaging-darkroom;147;146;146;146;147;146;147;147;145;148 11:12:15 INFO - PROCESS | 17827 | |7;imaging-desaturate;95;95;94;95;95;95;96;96;96;96 11:12:15 INFO - PROCESS | 17827 | |8;json-parse-financial;66;64;65;63;64;80;65;64;65;65 11:12:15 INFO - PROCESS | 17827 | |9;json-stringify-tinderbox;66;66;65;66;67;65;66;65;65;65 11:12:15 INFO - PROCESS | 17827 | |10;stanford-crypto-aes;84;84;84;83;84;92;83;90;83;83 11:12:15 INFO - PROCESS | 17827 | |11;stanford-crypto-ccm;149;142;142;141;148;149;141;146;175;148 11:12:15 INFO - PROCESS | 17827 | |12;stanford-crypto-pbkdf2;176;174;174;172;176;175;174;173;187;177 11:12:15 INFO - PROCESS | 17827 | |13;stanford-crypto-sha256-iterative;74;69;73;69;70;70;69;69;68;68 11:12:15 INFO - PROCESS | 17827 | __end_tp_report 11:12:15 INFO - PROCESS | 17827 | __start_cc_report 11:12:15 INFO - PROCESS | 17827 | _x_x_mozilla_cycle_collect,1986 11:12:15 INFO - PROCESS | 17827 | __end_cc_report 11:12:15 INFO - PROCESS | 17827 | __startTimestamp1476727935605__endTimestamp 11:12:15 INFO - PROCESS | 17827 | 11:12:15 INFO - PROCESS | 17827 | ------- Summary: start ------- 11:12:15 INFO - PROCESS | 17827 | Number of tests: 14 11:12:15 INFO - PROCESS | 17827 | 11:12:15 INFO - PROCESS | 17827 | [#0] ai-astar Cycles:10 Average:113.80 Median:114.00 stddev:1.32 (1.2%) stddev-sans-first:0.93 11:12:15 INFO - PROCESS | 17827 | Values: 111.0 115.0 116.0 114.0 114.0 114.0 113.0 114.0 113.0 114.0 11:12:15 INFO - PROCESS | 17827 | 11:12:15 INFO - PROCESS | 17827 | [#1] audio-beat-detection Cycles:10 Average:136.50 Median:130.50 stddev:14.24 (10.9%) stddev-sans-first:14.10 11:12:15 INFO - PROCESS | 17827 | Values: 151.0 127.0 129.0 160.0 128.0 131.0 125.0 125.0 159.0 130.0 11:12:15 INFO - PROCESS | 17827 | 11:12:15 INFO - PROCESS | 17827 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 11:12:15 INFO - PROCESS | 17827 | Values: 162.0 161.0 162.0 160.0 163.0 160.0 161.0 160.0 161.0 160.0 11:12:15 INFO - PROCESS | 17827 | 11:12:15 INFO - PROCESS | 17827 | [#3] audio-fft Cycles:10 Average:83.50 Median:76.50 stddev:12.26 (16.0%) stddev-sans-first:12.77 11:12:15 INFO - PROCESS | 17827 | Values: 77.0 76.0 77.0 109.0 78.0 88.0 76.0 76.0 102.0 76.0 11:12:15 INFO - PROCESS | 17827 | 11:12:15 INFO - PROCESS | 17827 | [#4] audio-oscillator Cycles:10 Average:93.20 Median:84.00 stddev:14.91 (17.7%) stddev-sans-first:15.43 11:12:15 INFO - PROCESS | 17827 | Values: 84.0 84.0 114.0 84.0 84.0 84.0 108.0 85.0 84.0 121.0 11:12:15 INFO - PROCESS | 17827 | 11:12:15 INFO - PROCESS | 17827 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 11:12:15 INFO - PROCESS | 17827 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 116.0 118.0 117.0 117.0 11:12:15 INFO - PROCESS | 17827 | 11:12:15 INFO - PROCESS | 17827 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 11:12:15 INFO - PROCESS | 17827 | Values: 147.0 146.0 146.0 146.0 147.0 146.0 147.0 147.0 145.0 148.0 11:12:15 INFO - PROCESS | 17827 | 11:12:15 INFO - PROCESS | 17827 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 11:12:15 INFO - PROCESS | 17827 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 96.0 96.0 96.0 96.0 11:12:15 INFO - PROCESS | 17827 | 11:12:15 INFO - PROCESS | 17827 | [#8] json-parse-financial Cycles:10 Average:66.10 Median:65.00 stddev:4.95 (7.6%) stddev-sans-first:5.25 11:12:15 INFO - PROCESS | 17827 | Values: 66.0 64.0 65.0 63.0 64.0 80.0 65.0 64.0 65.0 65.0 11:12:15 INFO - PROCESS | 17827 | 11:12:15 INFO - PROCESS | 17827 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 11:12:15 INFO - PROCESS | 17827 | Values: 66.0 66.0 65.0 66.0 67.0 65.0 66.0 65.0 65.0 65.0 11:12:15 INFO - PROCESS | 17827 | 11:12:15 INFO - PROCESS | 17827 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:84.00 stddev:3.23 (3.8%) stddev-sans-first:3.41 11:12:15 INFO - PROCESS | 17827 | Values: 84.0 84.0 84.0 83.0 84.0 92.0 83.0 90.0 83.0 83.0 11:12:15 INFO - PROCESS | 17827 | 11:12:15 INFO - PROCESS | 17827 | [#11] stanford-crypto-ccm Cycles:10 Average:148.10 Median:148.00 stddev:10.03 (6.8%) stddev-sans-first:10.63 11:12:15 INFO - PROCESS | 17827 | Values: 149.0 142.0 142.0 141.0 148.0 149.0 141.0 146.0 175.0 148.0 11:12:15 INFO - PROCESS | 17827 | 11:12:15 INFO - PROCESS | 17827 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.80 Median:175.50 stddev:4.21 (2.4%) stddev-sans-first:4.47 11:12:15 INFO - PROCESS | 17827 | Values: 176.0 174.0 174.0 172.0 176.0 175.0 174.0 173.0 187.0 177.0 11:12:15 INFO - PROCESS | 17827 | 11:12:15 INFO - PROCESS | 17827 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:69.50 stddev:2.02 (2.9%) stddev-sans-first:1.51 11:12:15 INFO - PROCESS | 17827 | Values: 74.0 69.0 73.0 69.0 70.0 70.0 69.0 69.0 68.0 68.0 11:12:15 INFO - PROCESS | 17827 | -------- Summary: end -------- 11:12:15 INFO - PROCESS | 17827 | 11:12:16 INFO - TEST-INFO | 17827: exit 0 11:12:16 INFO - TEST-OK | kraken | took 64414ms 11:12:16 INFO - SUITE-END | took 1186s 11:12:17 INFO - Completed test suite (00:19:46) 11:12:17 INFO - javascript benchmark 11:12:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2539.454017386262, 2562.436264021917, 2594.675665541807, 2606.661134052573, 2615.699194592621, 4451.0, 4541.43232095988, 4660.4174478190225, 4692.953070469299, 4699.953000469995, 4560.4527456705155, 4574.405327307453, 4580.198465268573, 4583.0, 4584.3352713856475, 4176.394422808698, 4196.265653510639, 4206.095689426773, 4231.682623803212, 4235.110626768367, 4315.633171180438, 4333.588309110645, 4355.629771469429, 4358.150160718661, 4362.302031674933, 4223.598758117974, 4266.701330906838, 4286.39990401344, 4294.377315289281, 4365.476142862861, 4338.479382474124, 4339.631131353807, 4343.457067866517, 4372.278574035312, 4380.386745855582, 3971.920561588781, 3988.581198974095, 4133.503979522447, 4234.280172370704, 4256.87229383119, 4561.0, 4603.447586289667, 4604.930926036079, 4606.124836281129, 4680.742559159245, 4898.779554920037, 4900.6569540132205, 4919.409670839486, 4926.211806111005, 4967.329410529568, 4866.489018653026, 4928.28539861718, 4931.4821943696115, 4942.728149951751, 5009.273655319958, 4625.629949604024, 4626.421697287839, 4629.837955671535, 4639.141758774604, 4640.930386044212, 5056.191009438472, 5057.418396884332, 5065.3161823153405, 5083.466236045236, 5089.0, 4820.807167713252, 4861.173600487926, 4868.975655121772, 4875.804967801319, 4875.853724388274, 4957.578605818474, 4962.6774259673, 4967.031428871408, 4971.676841005323, 5032.547070763649, 4959.677620954699, 5000.699958002531, 5052.317937078521, 5067.543921047123, 5068.062408454448, 4983.252512123138, 4989.5758860496535, 4995.150824359867, 4995.850124496271, 5039.899202015939, 3815.5802861685193, 3865.5168103987003, 3871.245107204068, 3923.6861051115843, 3929.410588411704, 3391.033555436689, 3428.297199074184, 3436.2783815398548, 3444.983729799715, 3507.684308412255, 4277.978610106929, 4281.97859010703, 4283.485981682218, 4334.934975975363, 4339.500957389878, 4735.668503204743, 4914.434839993446, 4922.975385123052, 4940.827071052496, 4981.850544483671, 4168.333066709312, 4214.346776249687, 4282.978585107055, 4308.224519586442, 4338.783060846945, 4483.417155769795, 4484.75333856641, 4490.932636010462, 4508.504064552896, 4536.4102666653125, 4736.763161841825, 4750.762461876961, 4751.40607424072, 4751.976240118777, 4807.927881081857, 4748.62011039123, 4820.855374338776, 4831.371921650163, 5014.398272207212, 5023.572996295356, 4601.723896566216, 4680.976595117003, 4717.103750287434, 4723.031778485333, 4782.832600859092, 4903.117438860897, 4905.583025442877, 4908.190148625579, 4931.580815630568, 4969.925451118163, 4963.883126296699, 4968.205087186033, 4969.155243608523, 4977.9502204978935, 5023.6985780853265, 4659.184642687448, 4714.269288260325, 4795.184818580919, 4838.274258861199, 4850.151223535797, 4816.783244754065, 4848.0546293472435, 4852.902941941212, 4896.045271172087, 4906.215005599087, 4759.976200118977, 4771.665983381269, 4801.615870730403, 4803.711777293373, 4858.392700912386, 4757.738324392191, 4820.469748327751, 4826.469088400203, 4876.512348765237, 4907.705537667752, 4713.128071306819, 4751.524847515221, 4763.571278584944, 4776.904461910812, 4777.211760059551], "value": 4532.362885767925, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.057482567049, 556.379636705074, 558.3885645218486, 573.9856503587409, 578.5718568259488, 26709.732902670967, 37884.43173352398, 39397.212055758864, 39506.209875802466, 42764.572354276446, 40063.39904901429, 40368.59631403685, 40544.59455405445, 40558.18883622326, 40601.390979135336, 7382.224866389019, 7519.586422746746, 7525.623718814065, 7528.58592777397, 7529.47293689442, 7587.089549254069, 7653.693852245931, 7670.539767613961, 7673.884891726629, 7674.309312161904, 7652.464327497078, 7697.615119244043, 7701.768946931601, 7702.383809295271, 7703.576303303316, 7586.772396828076, 7606.733764318277, 7615.961920190419, 7618.276263754934, 7644.044494438195, 7451.925480745177, 7502.6623801929045, 7508.249175082448, 7519.13529944058, 7526.36025937796, 37092.81453592742, 37462.0, 37480.62519374826, 37498.0, 37509.249815003546, 2795.7623601993855, 2810.0867218153976, 2862.77097832175, 2955.9999999999786, 3197.232664160608, 27493.725062749516, 28330.575041374395, 28335.291617709518, 29137.854310728522, 29251.707482925325, 3295.8352082395786, 3338.7162091222276, 3438.2263990601914, 3515.0860776198115, 3519.6480351964856, 171786.0, 172170.0, 278818.0, 286050.0, 288460.0, 50389.496105039216, 56302.39917611152, 56658.0, 56685.43314566884, 56771.14843277354, 33812.32375352479, 34920.0, 59345.70327148337, 60071.39928600746, 60277.0, 14193.503227387198, 14262.714745705236, 14317.64205894861, 14380.209088500023, 14387.568372948828, 11280.548778048951, 11338.886611133783, 11385.203035787581, 11389.088872890148, 11403.315801051964, 18607.0, 18614.906925465286, 18750.0, 18753.24987000532, 18790.624187516172, 7025.648717564101, 7135.857282854314, 7286.854262914712, 7320.194778574352, 7388.261173882569, 763.6792547130108, 829.6432534010434, 880.7621942075604, 914.7530166855045, 919.7838507950627, 26673.466530669666, 27279.86360068187, 27869.86065069702, 28014.579781303295, 29992.25019374533, 737.5316673912105, 859.2536540682619, 874.191372979991, 900.0, 904.9954750226339, 11113.611023614296, 13301.135426197266, 13889.097208681404, 13919.897551460153, 14063.2968351582, 172735.0, 173697.0, 174221.0, 174683.0, 352439.0, 46608.53391466042, 46916.53083469121, 46965.29552056722, 46981.76509117501, 47099.0, 995.5818556206266, 1039.656913218636, 1123.9494222759995, 1178.5268414481898, 1178.5544994137028, 26655.866720666272, 27488.312792180357, 28084.578731318637, 28307.150785476468, 28319.433611327247, 40382.596174037884, 41045.794771025954, 41059.7947010275, 41119.177616448105, 41170.794146029075, 304163.0, 307468.0, 307802.0, 308402.0, 367237.0, 35314.0, 37394.813025934694, 38222.42666360062, 38732.80633596814, 39060.218795624496, 37954.81022594869, 38566.22867542577, 40838.1832363357, 41236.58763412447, 41591.792041039604, 34840.30319393649, 35505.46741798927, 35610.82194589011, 35678.0, 35988.28023439464, 35119.47320790139, 35679.82160089183, 35702.28595428129, 35744.28511429705, 35764.284714306086, 34345.82827085849, 34941.47587786135, 35166.82416587901, 35233.1191720209, 35348.646513534535, 30408.0, 31648.525272120474, 31860.840695796374, 32501.0, 32710.50934236036, 24563.63154552719, 24749.611166697494, 24878.37804054913, 25026.0, 25398.873005634854], "value": 16980.970297621854, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.0979355739504, 344.8896353166987, 348.71057022671204, 353.6445871898742, 366.70113857206377, 11872.168948173621, 12830.422630981604, 15728.685426291482, 15952.20238988049, 16559.420420285292, 16605.0, 16909.23908424121, 17033.233504492327, 17187.74218386722, 17233.31066757328, 4596.919723864889, 4949.2823540586505, 4979.850604481853, 5185.585153187736, 5188.92216616751, 4973.651844370896, 5101.489851014888, 5105.05556472052, 5111.105556527611, 5114.514121158484, 5074.416442109149, 5085.211792172201, 5089.4910508949, 5096.592272618182, 5237.8952420951555, 5392.2181283713835, 5530.474604912527, 5530.5022547970475, 5533.0, 5536.363318218416, 5265.631405801595, 5318.73406329682, 5361.061814182542, 5371.785128594852, 5450.890982180374, 19617.21531138753, 20091.497712557302, 20126.094325755377, 20351.389458316273, 20399.89800051005, 1773.9911300443416, 1890.253349926785, 1901.591157901044, 2061.360978096795, 2300.18343488061, 8599.63575203268, 8668.26319762821, 9170.81658366829, 9261.675841345588, 9270.30472714549, 1636.6563021765444, 1665.608581983233, 1714.8799584029123, 1808.3580328983153, 1809.1406581873637, 67683.66158169178, 68210.0, 68749.65625171892, 69024.3097569023, 69617.0, 9635.710928672152, 9817.214622830157, 9962.750931226778, 10034.197264218845, 10104.141148002502, 13785.862141378459, 13803.17180969145, 13819.170849749047, 13832.792508112387, 13839.962002849625, 6966.663578606558, 7069.646517674199, 7120.679569419389, 7300.233475484997, 7305.050343455423, 6601.702923368364, 6657.966710166515, 6831.521793474509, 6833.897491537631, 6872.072270243453, 4154.750714957112, 4215.852445164466, 4240.300350442142, 4367.781610919441, 4379.386885835986, 1748.2395158106265, 1784.1703607822426, 1801.4325487471403, 1812.3747307179003, 1829.039754129093, 815.1155995744565, 826.3802148388709, 867.089555966233, 902.8600566912139, 920.8756817829641, 16562.420315288906, 16617.584560385847, 16621.584460388345, 16734.83265167333, 17408.303667853397, 761.455559275121, 793.2384910485998, 797.8324551844178, 824.6083110522574, 871.8910136232971, 9083.318751093695, 9184.448933064037, 9574.95212523933, 9644.807103857884, 9966.352187107816, 395145.0, 398206.0, 439358.0, 444327.0, 450529.0, 65187.0, 73758.0, 77530.0, 78338.60830695811, 80027.99790015772, 381.6012267180803, 397.60835576956674, 399.5784447407954, 400.50937601438585, 401.68668438617925, 9826.950865245914, 9911.504424778876, 9928.453935033642, 10077.344972576759, 10093.0, 34730.0, 34737.13157171091, 35219.47170792492, 35996.64003359933, 36241.818790905876, 47756.5224347766, 48170.0, 50668.23997640112, 50803.237951431496, 51001.83970564692, 7605.505642133244, 7650.2349765023055, 7679.846403071795, 7730.381569474541, 7840.215978402114, 7802.960985195038, 9448.622055117718, 10641.733956651145, 10760.569577216824, 11537.07703383744, 9174.486209775312, 9524.571394287412, 9604.135627793532, 9721.513924303898, 10116.898831011596, 9039.186473217442, 9139.451632902048, 9388.530573471162, 9950.800983980134, 10309.845352319571, 9712.854307185256, 9738.561764720745, 9866.210703143875, 10163.898361016296, 10642.574297028032, 6935.895961560682, 6977.511574189758, 7073.115860517435, 7191.496595238283, 7254.6735396908325, 7660.846783064196, 9444.291678124306, 9497.667581634609, 9552.092551207625, 9583.233341332816], "value": 7701.521692101585, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1128.7178205448638, 1291.6125162451265, 1330.9733805323895, 1345.4887142885702, 1633.926473308701, 6334.524910631704, 7127.928720712791, 7352.154502232245, 7383.963080184605, 7582.393408527319, 7407.25927407259, 7443.8883416748795, 7454.329110380065, 7455.62721863906, 7471.850562988737, 2076.169532187122, 2093.288281984125, 2113.4399384163207, 2114.217739436403, 2114.577084583082, 2056.4139220322213, 2058.9616279882885, 2062.669972804352, 2089.592529456749, 2091.16353458617, 2040.4490787487368, 2047.0276618606117, 2074.3984244569056, 2074.9936280903826, 2100.0339843671927, 2033.5729496805689, 2039.2149022626247, 2040.55107876267, 2042.7650820155723, 2051.3538235455785, 2046.2838006697536, 2062.0308455026266, 2069.637813382667, 2071.0, 2079.740032495938, 7170.533915295541, 7215.819604509877, 7281.6723247453465, 7373.225811289844, 7426.962865185694, 4197.9370309445385, 4364.476262848447, 4375.671824613135, 4376.081022985177, 4377.846775362847, 2724.50958827411, 2861.3704984903497, 2936.236578489587, 2940.7500362469214, 2944.749696275819, 876.5354362188051, 885.1281487734576, 885.9335549833788, 890.559173209259, 891.9866202006975, 9577.090176433228, 9636.95181524095, 9646.083622055894, 9683.515824208762, 9689.660861869801, 3638.235970446236, 3781.3949768036982, 3839.7120215983914, 3908.843646254118, 3916.8629097981434, 7748.070231572247, 7764.767056988299, 7771.10632277284, 7773.106092799288, 7777.066751989797, 4162.375643653476, 4164.208800327989, 4166.83332666696, 4167.5207351154395, 4168.583141685807, 3471.8264086795557, 3592.407252803258, 3828.0, 3828.406596977473, 3856.73002889795, 3191.5159450855463, 3192.6009248843893, 3307.9007629771145, 3321.8837340692958, 3343.3981883261245, 958.0946006024241, 962.0908241711516, 972.776261459854, 978.1685567267907, 995.1938929467154, 729.6023667101442, 778.7780482562442, 782.9569373684388, 795.3676826922494, 795.5703919883198, 4575.359449677047, 4625.213713668684, 4673.766311684402, 4821.927671084936, 4839.540243676845, 811.350919264586, 821.1829229916272, 823.7322870067132, 869.2567854484452, 870.6473878079388, 3076.2770748873995, 3087.228192951762, 3101.2712012677002, 3176.1583180457196, 3198.6801319867827, 8462.19609137131, 8877.0, 8893.28853691703, 8904.065073167354, 8908.06465321145, 8855.822883542422, 8863.335249856287, 8866.42368246062, 8873.689420870238, 8876.334274929277, 6926.272741362185, 7053.612051337123, 7064.222935477196, 7068.752593659197, 7069.469789765788, 4536.228841097088, 4643.419572553431, 4687.2031754602485, 4698.577128058354, 4733.763311834464, 8336.208060234268, 8343.916560834314, 8346.248837604644, 8359.373047021376, 8385.0, 8429.325653947546, 8451.492910425393, 8614.956925215334, 8648.697295594624, 8662.220400164015, 5457.426970168234, 5747.0, 5978.790742323998, 5990.7903223386975, 6000.189974353407, 6378.840528986812, 6550.967245163934, 6551.6069035858, 6564.245111812012, 6566.8358291043105, 6139.109829074849, 6308.306086330592, 6414.198225221848, 6498.512611554058, 6586.901196482152, 6096.481799046954, 6146.754129834757, 6215.34738852414, 6242.0, 6358.300586935526, 5486.753096110605, 5625.943740562706, 5678.943210568007, 5855.414458554111, 5937.376575459514, 4182.079942412664, 4209.915801683888, 4210.726302790309, 4273.829046838092, 4447.0, 4096.201240758142, 4138.151678905877, 4164.500259968823, 4254.51073126582, 4418.403515525363], "value": 3813.783758960253, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.2022877544304, 301.9969800301996, 302.04252519513153, 307.20434075743833, 313.0764245475847, 4682.735661371432, 4751.881202969923, 4757.643176761744, 4768.570828625423, 4792.544708252719, 4733.704153485557, 4741.122892264925, 4758.881027974302, 4764.857054288377, 4770.475247722757, 3558.5195998540253, 3626.764260323084, 3679.5952445231005, 3772.7927063339607, 3785.9621403786023, 3768.5100936878302, 3770.001898993538, 3773.3208022555928, 3773.622637736218, 3779.300829346566, 3731.533558305212, 3737.86917457889, 3741.8129093545213, 3743.588205297429, 3745.494358261627, 3558.5018097466377, 3661.7916087690996, 3669.174435751961, 3718.2935242303874, 3751.8499260029703, 3339.1819004343847, 3341.214814518586, 3341.677534113792, 3349.0, 3350.8492117854753, 4656.697314674535, 4660.41545874401, 4661.230896902007, 4662.8134874604975, 4668.649851261169, 4140.358244472081, 4267.978660106711, 4280.293751530994, 4284.978575107136, 4306.428153723899, 4953.529414705597, 4975.228839529878, 4983.152864013126, 4989.201727723546, 4991.176455884774, 3665.486831843544, 3679.1537946272238, 3682.705383569308, 3691.1325838427947, 3694.2796154749835, 5088.0, 5200.517852412045, 5209.661372010807, 5239.973800131013, 5252.474752524755, 3743.9251214975548, 3771.2834561433788, 3775.2638235544355, 3776.3950321113416, 3788.981055094762, 3822.197338558878, 3829.4064420014943, 3832.156925476391, 3833.923321533554, 3854.9229015419533, 4313.741175529478, 4326.394304797331, 4347.717423360116, 4354.281543545279, 4366.672499562482, 4828.758562071883, 4999.3000979862845, 5017.573506251936, 5026.547610715053, 5044.2937988681615, 1322.3983087695076, 1328.2030781531005, 1333.2134040915905, 1333.8466076401144, 1340.3365334159653, 823.3865770001267, 853.8719192121232, 862.8144948835904, 866.4151697604092, 874.6588830356167, 4261.424707664426, 4346.413234213404, 4427.911441771146, 4468.106378724268, 4480.798364073559, 5113.948860511422, 5134.101532231844, 5136.897262054738, 5140.3550863723995, 5155.278261043457, 4472.881779555111, 4485.932711009337, 4486.484054333728, 4505.391772110723, 4508.594226519629, 2628.7108418073994, 2717.5787752897936, 2736.0, 2738.835669859775, 2741.314671332167, 4905.901881962341, 4907.2393778964315, 4909.288153217834, 4911.778969946289, 4931.457539670633, 5055.570276526463, 5273.551748101454, 5280.524752772269, 5283.471652834763, 5288.550473209821, 4858.663867436412, 4866.7566621668775, 4877.6585639004925, 4883.682560633548, 4897.191963326011, 5099.515546023122, 5116.1581830540235, 5119.948800511947, 5141.614378921521, 5141.742912854267, 4849.296851956376, 5013.824516142064, 5028.547430731252, 5057.912548801878, 5086.3896332440345, 4948.851534453972, 4971.726555039363, 4979.751012449436, 4981.900361992667, 4988.900221995613, 3629.5825980012637, 3652.598214196383, 3655.853765849336, 3657.2868290684128, 3662.230931504307, 5100.132977393926, 5177.715225662474, 5184.559312458332, 5219.686818790885, 5220.399654039834, 5043.394792624908, 5066.873328166678, 5075.467075956972, 5087.23691446286, 5090.796368145233, 5038.496150384932, 5051.646384753032, 5053.570446512088, 5061.468545802638, 5069.7718602662235, 4747.691400058985, 4977.64009293718, 4989.750512474289, 5000.874628282892, 5014.147594908802, 4827.300041493893, 4942.627538781333, 5054.721990290569, 5071.315372424823, 5087.949120508895, 4820.542048505386, 4956.950430495649, 4959.11553609626, 4965.354503914468, 4966.528179822911], "value": 3803.647854805332, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.5813577020887, 595.8391234366721, 616.3128112154949, 679.2731776998611, 694.5520139510016, 12777.0, 13690.589282321545, 13692.0, 13698.794518082212, 13703.38334774935, 12766.872331276685, 12919.93540032301, 12923.41844616992, 12938.805917911239, 12949.158304710187, 535.2239253083026, 548.6351576201841, 730.8209488675282, 736.6942718771703, 758.0978635423855, 747.7644541969262, 755.3390783064818, 756.7275780718965, 756.8334966307431, 757.3221966340122, 790.6521130702502, 790.8695065314245, 791.0823444804, 791.1376599506536, 791.9287264146226, 567.3673853653147, 583.950364219042, 762.0702742653954, 782.9882551761757, 783.7883771381723, 574.431313000131, 576.9711514424262, 579.860833399981, 580.8838232353504, 581.3866370978658, 12571.497140114385, 12576.937115314366, 12585.24488530691, 12593.496260149583, 12615.558455454107, 11287.0, 11508.13688973322, 11563.710907227303, 11664.0, 12063.336516491589, 11226.796763446024, 11440.084793216523, 11524.88475115255, 11528.250663706833, 11594.304341739522, 3766.164940590286, 3806.847726090953, 3899.0, 3979.5423526294558, 4027.0335119571387, 58183.41816581865, 59143.70428147875, 60161.398386016015, 60891.39108608946, 61081.6945915272, 9373.109554592304, 9555.331126821195, 9601.951990240004, 9689.854652180082, 9765.16996055329, 16753.497395078168, 17433.0, 17476.126193690263, 17821.821781782277, 17853.28586856511, 6481.222253329631, 6566.4418524425, 6624.171978502687, 6632.237292711304, 6709.094272273181, 3523.4890940813953, 3567.23304489536, 3573.6783689468075, 3586.8027258501033, 3600.261946301002, 2809.592609071673, 2898.7970842041277, 2934.559816027613, 2943.2936095336963, 2944.573036909679, 479.95920346770913, 487.9121758083508, 491.53549895349266, 495.3115169913823, 498.09098395428487, 520.5029197116744, 561.1498579651831, 588.0180099234288, 601.8525461261931, 603.3755063509246, 7642.541447513167, 7933.761987140279, 7971.285799150462, 8020.879686804586, 8101.513909165469, 554.8557375082507, 580.2978396140633, 582.3797655496883, 585.9912101318483, 590.8079874040953, 3532.717382609385, 3865.69074474047, 3937.822797974098, 3987.4018897165656, 4009.3384591542654, 93609.53195234116, 97738.0, 101082.0, 105288.47355763172, 105689.47155264174, 87264.56367718248, 89253.0, 90824.0, 92352.53823730838, 92631.0, 65894.67052664707, 74176.25823741693, 75137.62431187808, 77088.22911770923, 78040.60979695065, 7360.484766066324, 7618.466707330434, 7620.8475830484185, 7752.573608451589, 7820.257075577811, 31805.840970794998, 40303.79848100858, 44622.77688611666, 45549.31676024796, 46343.76828115838, 50854.49145508498, 51895.0, 54404.91190176095, 58411.4158858406, 59428.40571594229, 9611.0, 9839.212862970802, 9874.111329980336, 11092.168087393638, 11169.888301116885, 12433.254004759743, 12539.49842006346, 12684.175528590613, 13085.345732713136, 13437.462501500222, 11332.263402878787, 11343.149263805082, 11570.190086694187, 11617.88382116168, 12045.277283363026, 10110.39337639744, 10152.238582106223, 10416.583336666448, 10490.790184196121, 11228.270162439416, 11277.830832537682, 11359.204855660355, 11373.20387572895, 11481.827772583585, 11568.652940411801, 9004.639814407612, 9499.905000949902, 9563.952180239054, 9584.616615335308, 9791.559379828068, 9049.864252036094, 9242.306826988137, 9964.202863770735, 10000.399976001463, 10006.549705263425], "value": 6349.452480989546, "unit": "score"}], "name": "dromaeo_css", "value": 6159.345815186089, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 115.0, 116.0, 114.0, 114.0, 114.0, 113.0, 114.0, 113.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 127.0, 129.0, 160.0, 128.0, 131.0, 125.0, 125.0, 159.0, 130.0], "value": 136.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 160.0, 163.0, 160.0, 161.0, 160.0, 161.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 109.0, 78.0, 88.0, 76.0, 76.0, 102.0, 76.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 114.0, 84.0, 84.0, 84.0, 108.0, 85.0, 84.0, 121.0], "value": 93.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 118.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0, 145.0, 148.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 65.0, 63.0, 64.0, 80.0, 65.0, 64.0, 65.0, 65.0], "value": 66.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 66.0, 67.0, 65.0, 66.0, 65.0, 65.0, 65.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 83.0, 84.0, 92.0, 83.0, 90.0, 83.0, 83.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 142.0, 142.0, 141.0, 148.0, 149.0, 141.0, 146.0, 175.0, 148.0], "value": 148.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 174.0, 174.0, 172.0, 176.0, 175.0, 174.0, 173.0, 187.0, 177.0], "value": 175.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 69.0, 73.0, 69.0, 70.0, 70.0, 69.0, 69.0, 68.0, 68.0], "value": 69.9, "unit": "score"}], "name": "kraken", "value": 1557.1999999999998, "alertThreshold": 2.0}]} 11:12:17 INFO - Return code: 0 11:12:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:12:17 INFO - # TBPL SUCCESS # 11:12:17 INFO - Running post-action listener: _resource_record_post_action 11:12:17 INFO - [mozharness: 2016-10-17 18:12:17.423632Z] Finished run-tests step (success) 11:12:17 INFO - Running post-run listener: _resource_record_post_run 11:12:17 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 8192; Write bytes: 405131264; Read time: 16; Write time: 277404 11:12:17 INFO - TinderboxPrint: CPU usage
13.0% 11:12:17 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 16 11:12:17 INFO - TinderboxPrint: I/O write bytes / time
405,131,264 / 277,404 11:12:17 INFO - TinderboxPrint: CPU idle
8,348.8 (87.0%) 11:12:17 INFO - TinderboxPrint: CPU user
1,201.8 (12.5%) 11:12:17 INFO - TinderboxPrint: Swap in / out
0 / 0 11:12:17 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110518272; Read time: 0; Write time: 91648 11:12:17 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293699584; Read time: 8; Write time: 185728 11:12:18 INFO - Running post-run listener: _upload_blobber_files 11:12:18 INFO - Blob upload gear active. 11:12:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:12:18 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 11:12:18 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', 'Larch-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:12:18 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 Larch-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:12:18 INFO - (blobuploader) - INFO - Open directory for files ... 11:12:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:12:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:12:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:12:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:12:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:12:19 INFO - (blobuploader) - INFO - Done attempting. 11:12:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:12:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:12:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:12:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:12:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:12:23 INFO - (blobuploader) - INFO - Done attempting. 11:12:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:12:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:12:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:12:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:12:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:12:24 INFO - (blobuploader) - INFO - Done attempting. 11:12:24 INFO - (blobuploader) - INFO - Iteration through files over. 11:12:24 INFO - Return code: 0 11:12:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:12:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:12:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/73713bf6a061614d718193278a737829b4ab0b426cec74b6190a937e63fe6d6b0986708f95c1c68c5c24c108d5e3652411f9ff1708ba06f7619833cc000d5e3f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/5971c4e94f0c1733032d96cb36aa2feffd2b1e9a0afd9629c28df08dc7a59a78a0f729f59c5ded68fdddbae6f94f3afc9771e6123f07ea703e2ab638dba5d7d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/b40f6239cdd02eff3cf98a81a8b58a3daadf0570595d44835b9eadfe47c36fd5b73b4fa3dedefa749eabace0a788e6fb5d663c6952260deaca5cdb5d3d294189"} 11:12:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:12:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:12:24 INFO - Contents: 11:12:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/73713bf6a061614d718193278a737829b4ab0b426cec74b6190a937e63fe6d6b0986708f95c1c68c5c24c108d5e3652411f9ff1708ba06f7619833cc000d5e3f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/5971c4e94f0c1733032d96cb36aa2feffd2b1e9a0afd9629c28df08dc7a59a78a0f729f59c5ded68fdddbae6f94f3afc9771e6123f07ea703e2ab638dba5d7d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/b40f6239cdd02eff3cf98a81a8b58a3daadf0570595d44835b9eadfe47c36fd5b73b4fa3dedefa749eabace0a788e6fb5d663c6952260deaca5cdb5d3d294189"} 11:12:24 INFO - Running post-run listener: copy_logs_to_upload_dir 11:12:24 INFO - Copying logs to upload dir... 11:12:24 INFO - mkdir: /builds/slave/test/build/upload/logs 11:12:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.592340 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-17 11:12:24.644010) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 11:12:24.651120) ========= 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=923d835db2ba3686ebe126b700000192-1476726695.835542-952862576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/73713bf6a061614d718193278a737829b4ab0b426cec74b6190a937e63fe6d6b0986708f95c1c68c5c24c108d5e3652411f9ff1708ba06f7619833cc000d5e3f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/5971c4e94f0c1733032d96cb36aa2feffd2b1e9a0afd9629c28df08dc7a59a78a0f729f59c5ded68fdddbae6f94f3afc9771e6123f07ea703e2ab638dba5d7d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/b40f6239cdd02eff3cf98a81a8b58a3daadf0570595d44835b9eadfe47c36fd5b73b4fa3dedefa749eabace0a788e6fb5d663c6952260deaca5cdb5d3d294189"} build_url:https://queue.taskcluster.net/v1/task/P26QQXgPT32SB9NToImvPA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011344 build_url: 'https://queue.taskcluster.net/v1/task/P26QQXgPT32SB9NToImvPA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/73713bf6a061614d718193278a737829b4ab0b426cec74b6190a937e63fe6d6b0986708f95c1c68c5c24c108d5e3652411f9ff1708ba06f7619833cc000d5e3f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/5971c4e94f0c1733032d96cb36aa2feffd2b1e9a0afd9629c28df08dc7a59a78a0f729f59c5ded68fdddbae6f94f3afc9771e6123f07ea703e2ab638dba5d7d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/b40f6239cdd02eff3cf98a81a8b58a3daadf0570595d44835b9eadfe47c36fd5b73b4fa3dedefa749eabace0a788e6fb5d663c6952260deaca5cdb5d3d294189"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 11:12:24.684328) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 11:12:24.684750) ========= 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=923d835db2ba3686ebe126b700000192-1476726695.835542-952862576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004502 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 11:12:24.767759) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 11:12:24.768200) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 11:12:24.768871) ========= ========= Total master_lag: 0.19 =========