builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-006 starttime: 1479876316.49 results: success (0) buildid: 20161122192737 builduid: 22dc03a2ea0d4a52b9420076ba1ddcad revision: 90b691bf09f5cc4fe7d0c6445fcf5afa2c34eeee ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-22 20:45:16.493964) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-22 20:45:16.494394) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-22 20:45:16.494703) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-22 20:45:16.523234) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 20:45:16.523509) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1479866219.899489-291600571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-22 20:45:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 114M=0s 2016-11-22 20:45:17 (114 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127125 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 20:45:16.669147) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 20:45:16.669796) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1479866219.899489-291600571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020307 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 20:45:16.722730) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 20:45:16.723492) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 90b691bf09f5cc4fe7d0c6445fcf5afa2c34eeee --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 90b691bf09f5cc4fe7d0c6445fcf5afa2c34eeee --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=e31afd3c0f0de4e86ebe4d94000001b5-1479866219.899489-291600571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-22 20:45:17,433 truncating revision to first 12 chars 2016-11-22 20:45:17,433 Setting DEBUG logging. 2016-11-22 20:45:17,434 attempt 1/10 2016-11-22 20:45:17,434 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/90b691bf09f5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-22 20:45:17,748 unpacking tar archive at: mozilla-central-90b691bf09f5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.669969 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 20:45:17.408974) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-22 20:45:17.409298) ========= script_repo_revision: 90b691bf09f5cc4fe7d0c6445fcf5afa2c34eeee ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-22 20:45:17.409763) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-22 20:45:17.410076) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-22 20:45:17.420682) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-11-22 20:45:17.420984) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=e31afd3c0f0de4e86ebe4d94000001b5-1479866219.899489-291600571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:45:18 INFO - MultiFileLogger online at 20161122 20:45:18 in /builds/slave/test 20:45:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 20:45:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:45:18 INFO - {'append_to_log': False, 20:45:18 INFO - 'base_work_dir': '/builds/slave/test', 20:45:18 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 20:45:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:45:18 INFO - 'branch': 'Firefox-Non-PGO', 20:45:18 INFO - 'buildbot_json_path': 'buildprops.json', 20:45:18 INFO - 'config_files': ('talos/linux_config.py',), 20:45:18 INFO - 'default_actions': ('clobber', 20:45:18 INFO - 'read-buildbot-config', 20:45:18 INFO - 'download-and-extract', 20:45:18 INFO - 'populate-webroot', 20:45:18 INFO - 'create-virtualenv', 20:45:18 INFO - 'install', 20:45:18 INFO - 'run-tests'), 20:45:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:45:18 INFO - 'download_minidump_stackwalk': True, 20:45:18 INFO - 'download_symbols': 'ondemand', 20:45:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:45:18 INFO - 'tooltool.py': '/tools/tooltool.py', 20:45:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:45:18 INFO - '/tools/misc-python/virtualenv.py')}, 20:45:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:45:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:45:18 INFO - 'installer_path': 'installer.exe', 20:45:18 INFO - 'log_level': 'info', 20:45:18 INFO - 'log_name': 'talos', 20:45:18 INFO - 'log_to_console': True, 20:45:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:45:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:45:18 INFO - 'opt_config_files': (), 20:45:18 INFO - 'pip_index': False, 20:45:18 INFO - 'sps_profile': False, 20:45:18 INFO - 'sps_profile_interval': 0, 20:45:18 INFO - 'suite': 'dromaeojs', 20:45:18 INFO - 'system_bits': '32', 20:45:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:45:18 INFO - 'title': 'talos-linux64-ix-006', 20:45:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:45:18 INFO - 'use_talos_json': True, 20:45:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:45:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:45:18 INFO - 'work_dir': 'build'} 20:45:18 INFO - [mozharness: 2016-11-23 04:45:18.242657Z] Running clobber step. 20:45:18 INFO - Running pre-action listener: _resource_record_pre_action 20:45:18 INFO - Running main action method: clobber 20:45:18 INFO - rmtree: /builds/slave/test/build 20:45:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:45:19 INFO - Running post-action listener: _resource_record_post_action 20:45:19 INFO - [mozharness: 2016-11-23 04:45:19.213806Z] Finished clobber step (success) 20:45:19 INFO - [mozharness: 2016-11-23 04:45:19.213905Z] Running read-buildbot-config step. 20:45:19 INFO - Running pre-action listener: _resource_record_pre_action 20:45:19 INFO - Running main action method: read_buildbot_config 20:45:19 INFO - Using buildbot properties: 20:45:19 INFO - { 20:45:19 INFO - "project": "", 20:45:19 INFO - "product": "firefox", 20:45:19 INFO - "script_repo_revision": "production", 20:45:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 20:45:19 INFO - "repository": "", 20:45:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 20:45:19 INFO - "buildid": "20161122192737", 20:45:19 INFO - "pgo_build": "False", 20:45:19 INFO - "basedir": "/builds/slave/test", 20:45:19 INFO - "buildnumber": 308, 20:45:19 INFO - "slavename": "talos-linux64-ix-006", 20:45:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:45:19 INFO - "platform": "ubuntu64_hw", 20:45:19 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 20:45:19 INFO - "branch": "mozilla-central", 20:45:19 INFO - "repo_path": "mozilla-central", 20:45:19 INFO - "revision": "90b691bf09f5cc4fe7d0c6445fcf5afa2c34eeee", 20:45:19 INFO - "stage_platform": "linux64", 20:45:19 INFO - "builduid": "22dc03a2ea0d4a52b9420076ba1ddcad", 20:45:19 INFO - "slavebuilddir": "test" 20:45:19 INFO - } 20:45:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/I_OESP6IS1e7eV12pm_KNQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 20:45:19 INFO - Running post-action listener: _resource_record_post_action 20:45:19 INFO - [mozharness: 2016-11-23 04:45:19.216361Z] Finished read-buildbot-config step (success) 20:45:19 INFO - [mozharness: 2016-11-23 04:45:19.216449Z] Running download-and-extract step. 20:45:19 INFO - Running pre-action listener: _resource_record_pre_action 20:45:19 INFO - Running main action method: download_and_extract 20:45:19 INFO - mkdir: /builds/slave/test/build/tests 20:45:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:45:19 INFO - trying https://queue.taskcluster.net/v1/task/I_OESP6IS1e7eV12pm_KNQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 20:45:19 INFO - Downloading https://queue.taskcluster.net/v1/task/I_OESP6IS1e7eV12pm_KNQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 20:45:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I_OESP6IS1e7eV12pm_KNQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:45:19 INFO - Downloaded 1361 bytes. 20:45:19 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 20:45:19 INFO - Using the following test package requirements: 20:45:19 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 20:45:19 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:45:19 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:45:19 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:45:19 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:45:19 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:45:19 INFO - u'jsshell-linux-x86_64.zip'], 20:45:19 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:45:19 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:45:19 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 20:45:19 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:45:19 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:45:19 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:45:19 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:45:19 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:45:19 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:45:19 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 20:45:19 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:45:19 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:45:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I_OESP6IS1e7eV12pm_KNQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 20:45:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I_OESP6IS1e7eV12pm_KNQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:45:19 INFO - Fetch https://queue.taskcluster.net/v1/task/I_OESP6IS1e7eV12pm_KNQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:45:20 INFO - Http code: 200 20:45:20 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 20:45:20 INFO - x-amz-cf-id: G00a_MJ0NS0Zt8c4yTMSzXKOt1iWK7OZ6XbixUZbFxS6HsSmKrIG2g== 20:45:20 INFO - x-amz-version-id: WezVBwGbJCiaHGBFsy9R4cFXOLKGaHQ_ 20:45:20 INFO - Expected file size: 20183288 20:45:20 INFO - Obtained file size: 20183288 20:45:24 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:45:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I_OESP6IS1e7eV12pm_KNQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 20:45:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I_OESP6IS1e7eV12pm_KNQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:45:24 INFO - Fetch https://queue.taskcluster.net/v1/task/I_OESP6IS1e7eV12pm_KNQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:45:25 INFO - Http code: 200 20:45:25 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 20:45:25 INFO - x-amz-cf-id: zPFUCQOyNKVMBqWh9qp_jy15ST1DXS0HuXSKWP-gaZtao58abg-E-g== 20:45:25 INFO - x-amz-version-id: WezVBwGbJCiaHGBFsy9R4cFXOLKGaHQ_ 20:45:25 INFO - Expected file size: 20183288 20:45:25 INFO - Obtained file size: 20183288 20:45:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I_OESP6IS1e7eV12pm_KNQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 20:45:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I_OESP6IS1e7eV12pm_KNQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:45:29 INFO - Fetch https://queue.taskcluster.net/v1/task/I_OESP6IS1e7eV12pm_KNQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 20:45:30 INFO - Http code: 200 20:45:30 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 20:45:30 INFO - x-amz-cf-id: CTR2aAtiVHybdth0jpXIw7k7r4WaHAsJYcjwD-x0RlLB2TBjo6JXww== 20:45:30 INFO - x-amz-version-id: 7rJZaQcDOLSvtinI0XZPdhquAX0o4vcb 20:45:30 INFO - Expected file size: 14409392 20:45:30 INFO - Obtained file size: 14409392 20:45: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')]} 20:45:30 INFO - trying https://queue.taskcluster.net/v1/task/I_OESP6IS1e7eV12pm_KNQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 20:45:30 INFO - Downloading https://queue.taskcluster.net/v1/task/I_OESP6IS1e7eV12pm_KNQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 20:45:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I_OESP6IS1e7eV12pm_KNQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:45:32 INFO - Downloaded 55586453 bytes. 20:45:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I_OESP6IS1e7eV12pm_KNQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 20:45:32 INFO - mkdir: /builds/slave/test/properties 20:45:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:45:32 INFO - Writing to file /builds/slave/test/properties/build_url 20:45:32 INFO - Contents: 20:45:32 INFO - build_url:https://queue.taskcluster.net/v1/task/I_OESP6IS1e7eV12pm_KNQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 20:45:33 INFO - Running post-action listener: _resource_record_post_action 20:45:33 INFO - Running post-action listener: set_extra_try_arguments 20:45:33 INFO - [mozharness: 2016-11-23 04:45:33.324258Z] Finished download-and-extract step (success) 20:45:33 INFO - [mozharness: 2016-11-23 04:45:33.324486Z] Running populate-webroot step. 20:45:33 INFO - Running pre-action listener: _resource_record_pre_action 20:45:33 INFO - Running main action method: populate_webroot 20:45:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:45:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:45:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:45:33 INFO - '--tppagecycles', 20:45:33 INFO - '7'], 20:45:33 INFO - 'tests': ['tsvgm']}}, 20:45:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:45:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:45:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:45:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:45:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:45:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:45:33 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:45:33 INFO - 'talos_options': ['--disable-e10s'], 20:45:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:45:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:45:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:45:33 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:45:33 INFO - 'talos_options': ['--disable-e10s'], 20:45:33 INFO - 'tests': ['damp', 'tps']}, 20:45:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:45:33 INFO - 'tests': ['damp', 'tps']}, 20:45:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:45:33 INFO - 'tests': ['dromaeo_dom']}, 20:45:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:45:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:45:33 INFO - 'tests': ['basic_compositor_video']}, 20:45:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:45:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:45:33 INFO - 'tests': ['a11yr', 20:45:33 INFO - 'ts_paint', 20:45:33 INFO - 'tpaint', 20:45:33 INFO - 'sessionrestore', 20:45:33 INFO - 'sessionrestore_no_auto_restore', 20:45:33 INFO - 'tabpaint']}, 20:45:33 INFO - 'other-e10s': {'tests': ['a11yr', 20:45:33 INFO - 'ts_paint', 20:45:33 INFO - 'tpaint', 20:45:33 INFO - 'sessionrestore', 20:45:33 INFO - 'sessionrestore_no_auto_restore', 20:45:33 INFO - 'tabpaint']}, 20:45:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:45:33 INFO - 'ts_paint', 20:45:33 INFO - 'tpaint', 20:45:33 INFO - 'sessionrestore', 20:45:33 INFO - 'sessionrestore_no_auto_restore', 20:45:33 INFO - 'tabpaint']}, 20:45:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:45:33 INFO - 'ts_paint', 20:45:33 INFO - 'tpaint', 20:45:33 INFO - 'sessionrestore', 20:45:33 INFO - 'sessionrestore_no_auto_restore', 20:45:33 INFO - 'tabpaint']}, 20:45:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:45:33 INFO - 'tests': ['a11yr', 20:45:33 INFO - 'ts_paint', 20:45:33 INFO - 'tpaint', 20:45:33 INFO - 'sessionrestore', 20:45:33 INFO - 'sessionrestore_no_auto_restore', 20:45:33 INFO - 'tabpaint']}, 20:45:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:45:33 INFO - 'tests': ['a11yr', 20:45:33 INFO - 'ts_paint', 20:45:33 INFO - 'tpaint', 20:45:33 INFO - 'sessionrestore', 20:45:33 INFO - 'sessionrestore_no_auto_restore', 20:45:33 INFO - 'tabpaint']}, 20:45:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:45:33 INFO - 'tests': ['tsvgx', 20:45:33 INFO - 'tsvgr_opacity', 20:45:33 INFO - 'tart', 20:45:33 INFO - 'tscrollx', 20:45:33 INFO - 'cart']}, 20:45:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:45:33 INFO - 'tsvgr_opacity', 20:45:33 INFO - 'tart', 20:45:33 INFO - 'tscrollx', 20:45:33 INFO - 'cart']}, 20:45:33 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:45:33 INFO - 'talos_options': ['--disable-e10s'], 20:45:33 INFO - 'tests': ['tp5o']}, 20:45:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:45:33 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:45:33 INFO - 'talos_options': ['--disable-e10s', 20:45:33 INFO - '--xperf_path', 20:45:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:45:33 INFO - 'tests': ['tp5n']}, 20:45:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:45:33 INFO - 'talos_options': ['--xperf_path', 20:45:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:45:33 INFO - 'tests': ['tp5n']}}, 20:45:33 INFO - 'talos.zip': {'path': '', 20:45:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:45:33 INFO - Running post-action listener: _resource_record_post_action 20:45:33 INFO - [mozharness: 2016-11-23 04:45:33.344073Z] Finished populate-webroot step (success) 20:45:33 INFO - [mozharness: 2016-11-23 04:45:33.344161Z] Running create-virtualenv step. 20:45:33 INFO - Running pre-action listener: _resource_record_pre_action 20:45:33 INFO - Running main action method: create_virtualenv 20:45:33 INFO - Creating virtualenv /builds/slave/test/build/venv 20:45:33 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 20:45:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:45:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:45:33 INFO - Using real prefix '/usr' 20:45:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:45:33 INFO - Installing distribute.............................................................................................................................................................................................done. 20:45:35 INFO - Installing pip.................done. 20:45:35 INFO - Return code: 0 20:45:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:45:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:45:36 INFO - Reading from file tmpfile_stdout 20:45:36 INFO - Output received: 20:45:36 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) 20:45:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:45:36 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')]} 20:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:36 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')]} 20:45:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:36 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 0x7f5132e31e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197c130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0afc0>, '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 0x1a0bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c350>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1479866219.899489-291600571', '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 20:45:36 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 20:45:36 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 20:45:36 INFO - Using env: {'DISPLAY': ':0', 20:45:36 INFO - 'HOME': '/home/cltbld', 20:45:36 INFO - 'LANG': 'en_US.UTF-8', 20:45:36 INFO - 'LANGUAGE': 'en_US:en', 20:45:36 INFO - 'LOGNAME': 'cltbld', 20:45:36 INFO - 'MAIL': '/var/mail/cltbld', 20:45:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:36 INFO - 'MOZ_NO_REMOTE': '1', 20:45:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:45:36 INFO - 'NO_EM_RESTART': '1', 20:45:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:45:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:36 INFO - 'PWD': '/builds/slave/test', 20:45:36 INFO - 'SHELL': '/bin/bash', 20:45:36 INFO - 'SHLVL': '1', 20:45:36 INFO - 'TERM': 'linux', 20:45:36 INFO - 'TMOUT': '86400', 20:45:36 INFO - 'USER': 'cltbld', 20:45:36 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1479866219.899489-291600571', 20:45:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:36 INFO - '_': '/tools/buildbot/bin/python'} 20:45:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:36 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 20:45:36 INFO - Cleaning up... 20:45:36 INFO - Return code: 0 20:45:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:45:36 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')]} 20:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:36 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')]} 20:45:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:36 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 0x7f5132e31e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197c130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0afc0>, '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 0x1a0bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c350>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1479866219.899489-291600571', '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 20:45:36 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 20:45:36 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 20:45:36 INFO - Using env: {'DISPLAY': ':0', 20:45:36 INFO - 'HOME': '/home/cltbld', 20:45:36 INFO - 'LANG': 'en_US.UTF-8', 20:45:36 INFO - 'LANGUAGE': 'en_US:en', 20:45:36 INFO - 'LOGNAME': 'cltbld', 20:45:36 INFO - 'MAIL': '/var/mail/cltbld', 20:45:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:36 INFO - 'MOZ_NO_REMOTE': '1', 20:45:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:45:36 INFO - 'NO_EM_RESTART': '1', 20:45:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:45:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:36 INFO - 'PWD': '/builds/slave/test', 20:45:36 INFO - 'SHELL': '/bin/bash', 20:45:36 INFO - 'SHLVL': '1', 20:45:36 INFO - 'TERM': 'linux', 20:45:36 INFO - 'TMOUT': '86400', 20:45:36 INFO - 'USER': 'cltbld', 20:45:36 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1479866219.899489-291600571', 20:45:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:36 INFO - '_': '/tools/buildbot/bin/python'} 20:45:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:36 INFO - Downloading/unpacking psutil>=3.1.1 20:45:36 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 20:45:36 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 20:45:36 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 20:45:36 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 20:45:36 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 20:45:36 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 20:45:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:45:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:45:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:45:38 INFO - Installing collected packages: psutil 20:45:38 INFO - Running setup.py install for psutil 20:45:38 INFO - building 'psutil._psutil_linux' extension 20:45:38 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 20:45:38 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 20:45:38 INFO - building 'psutil._psutil_posix' extension 20:45:38 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 20:45:39 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 20:45:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:45:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:45:39 INFO - Successfully installed psutil 20:45:39 INFO - Cleaning up... 20:45:39 INFO - Return code: 0 20:45:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:45:39 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')]} 20:45:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:39 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')]} 20:45:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:39 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 0x7f5132e31e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197c130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0afc0>, '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 0x1a0bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c350>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1479866219.899489-291600571', '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 20:45:39 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 20:45:39 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 20:45:39 INFO - Using env: {'DISPLAY': ':0', 20:45:39 INFO - 'HOME': '/home/cltbld', 20:45:39 INFO - 'LANG': 'en_US.UTF-8', 20:45:39 INFO - 'LANGUAGE': 'en_US:en', 20:45:39 INFO - 'LOGNAME': 'cltbld', 20:45:39 INFO - 'MAIL': '/var/mail/cltbld', 20:45:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:39 INFO - 'MOZ_NO_REMOTE': '1', 20:45:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:45:39 INFO - 'NO_EM_RESTART': '1', 20:45:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:45:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:39 INFO - 'PWD': '/builds/slave/test', 20:45:39 INFO - 'SHELL': '/bin/bash', 20:45:39 INFO - 'SHLVL': '1', 20:45:39 INFO - 'TERM': 'linux', 20:45:39 INFO - 'TMOUT': '86400', 20:45:39 INFO - 'USER': 'cltbld', 20:45:39 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1479866219.899489-291600571', 20:45:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:39 INFO - '_': '/tools/buildbot/bin/python'} 20:45:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:45:39 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 20:45:39 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 20:45:39 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 20:45:39 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 20:45:39 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 20:45:39 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 20:45:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:45:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:45:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:45:41 INFO - Installing collected packages: mozsystemmonitor 20:45:41 INFO - Running setup.py install for mozsystemmonitor 20:45:41 INFO - Successfully installed mozsystemmonitor 20:45:41 INFO - Cleaning up... 20:45:41 INFO - Return code: 0 20:45:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:45:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:45:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:41 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 0x7f5132e31e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197c130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0afc0>, '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 0x1a0bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c350>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1479866219.899489-291600571', '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 20:45:41 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 20:45:41 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 20:45:41 INFO - Using env: {'DISPLAY': ':0', 20:45:41 INFO - 'HOME': '/home/cltbld', 20:45:41 INFO - 'LANG': 'en_US.UTF-8', 20:45:41 INFO - 'LANGUAGE': 'en_US:en', 20:45:41 INFO - 'LOGNAME': 'cltbld', 20:45:41 INFO - 'MAIL': '/var/mail/cltbld', 20:45:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:41 INFO - 'MOZ_NO_REMOTE': '1', 20:45:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:45:41 INFO - 'NO_EM_RESTART': '1', 20:45:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:45:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:41 INFO - 'PWD': '/builds/slave/test', 20:45:41 INFO - 'SHELL': '/bin/bash', 20:45:41 INFO - 'SHLVL': '1', 20:45:41 INFO - 'TERM': 'linux', 20:45:41 INFO - 'TMOUT': '86400', 20:45:41 INFO - 'USER': 'cltbld', 20:45:41 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1479866219.899489-291600571', 20:45:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:41 INFO - '_': '/tools/buildbot/bin/python'} 20:45:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:41 INFO - Downloading/unpacking jsonschema==2.5.1 20:45:41 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 20:45:41 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 20:45:41 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 20:45:41 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 20:45:41 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 20:45:41 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 20:45:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:45:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:45:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:45:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:45:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:45:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:45:43 INFO - Downloading functools32-3.2.3-2.tar.gz 20:45:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:45:43 INFO - warning: no files found matching '*.txt' 20:45:43 INFO - no previously-included directories found matching 'build' 20:45:43 INFO - no previously-included directories found matching 'dist' 20:45:43 INFO - no previously-included directories found matching '.git*' 20:45:43 INFO - Installing collected packages: jsonschema, functools32 20:45:44 INFO - Running setup.py install for functools32 20:45:44 INFO - warning: no files found matching '*.txt' 20:45:44 INFO - no previously-included directories found matching 'build' 20:45:44 INFO - no previously-included directories found matching 'dist' 20:45:44 INFO - no previously-included directories found matching '.git*' 20:45:44 INFO - Successfully installed jsonschema functools32 20:45:44 INFO - Cleaning up... 20:45:44 INFO - Return code: 0 20:45:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:45:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:45:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5132e31e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197c130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0afc0>, '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 0x1a0bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c350>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1479866219.899489-291600571', '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 20:45:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:45:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:45:44 INFO - Using env: {'DISPLAY': ':0', 20:45:44 INFO - 'HOME': '/home/cltbld', 20:45:44 INFO - 'LANG': 'en_US.UTF-8', 20:45:44 INFO - 'LANGUAGE': 'en_US:en', 20:45:44 INFO - 'LOGNAME': 'cltbld', 20:45:44 INFO - 'MAIL': '/var/mail/cltbld', 20:45:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:44 INFO - 'MOZ_NO_REMOTE': '1', 20:45:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:45:44 INFO - 'NO_EM_RESTART': '1', 20:45:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:45:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:44 INFO - 'PWD': '/builds/slave/test', 20:45:44 INFO - 'SHELL': '/bin/bash', 20:45:44 INFO - 'SHLVL': '1', 20:45:44 INFO - 'TERM': 'linux', 20:45:44 INFO - 'TMOUT': '86400', 20:45:44 INFO - 'USER': 'cltbld', 20:45:44 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1479866219.899489-291600571', 20:45:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:44 INFO - '_': '/tools/buildbot/bin/python'} 20:45:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:45:44 INFO - Cleaning up... 20:45:44 INFO - Return code: 0 20:45:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:45:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:45:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5132e31e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197c130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0afc0>, '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 0x1a0bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c350>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1479866219.899489-291600571', '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 20:45:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:45:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:45:44 INFO - Using env: {'DISPLAY': ':0', 20:45:44 INFO - 'HOME': '/home/cltbld', 20:45:44 INFO - 'LANG': 'en_US.UTF-8', 20:45:44 INFO - 'LANGUAGE': 'en_US:en', 20:45:44 INFO - 'LOGNAME': 'cltbld', 20:45:44 INFO - 'MAIL': '/var/mail/cltbld', 20:45:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:44 INFO - 'MOZ_NO_REMOTE': '1', 20:45:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:45:44 INFO - 'NO_EM_RESTART': '1', 20:45:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:45:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:44 INFO - 'PWD': '/builds/slave/test', 20:45:44 INFO - 'SHELL': '/bin/bash', 20:45:44 INFO - 'SHLVL': '1', 20:45:44 INFO - 'TERM': 'linux', 20:45:44 INFO - 'TMOUT': '86400', 20:45:44 INFO - 'USER': 'cltbld', 20:45:44 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1479866219.899489-291600571', 20:45:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:44 INFO - '_': '/tools/buildbot/bin/python'} 20:45:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:44 INFO - Downloading/unpacking blobuploader==1.2.4 20:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:45:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:45:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:45:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:45:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:45:46 INFO - Downloading blobuploader-1.2.4.tar.gz 20:45:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:45:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:45:46 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 20:45:46 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 20:45:46 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 20:45:46 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 20:45:46 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 20:45:46 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 20:45:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:45:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:45:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:45:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:45:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:45:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:45:47 INFO - Downloading docopt-0.6.1.tar.gz 20:45:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:45:47 INFO - Installing collected packages: blobuploader, requests, docopt 20:45:47 INFO - Running setup.py install for blobuploader 20:45:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:45:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:45:47 INFO - Running setup.py install for requests 20:45:47 INFO - Running setup.py install for docopt 20:45:47 INFO - Successfully installed blobuploader requests docopt 20:45:47 INFO - Cleaning up... 20:45:47 INFO - Return code: 0 20:45:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:45:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:47 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 0x7f5132e31e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197c130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0afc0>, '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 0x1a0bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c350>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1479866219.899489-291600571', '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 20:45:47 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 20:45:47 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 20:45:47 INFO - Using env: {'DISPLAY': ':0', 20:45:47 INFO - 'HOME': '/home/cltbld', 20:45:47 INFO - 'LANG': 'en_US.UTF-8', 20:45:47 INFO - 'LANGUAGE': 'en_US:en', 20:45:47 INFO - 'LOGNAME': 'cltbld', 20:45:47 INFO - 'MAIL': '/var/mail/cltbld', 20:45:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:47 INFO - 'MOZ_NO_REMOTE': '1', 20:45:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:45:47 INFO - 'NO_EM_RESTART': '1', 20:45:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:45:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:47 INFO - 'PWD': '/builds/slave/test', 20:45:47 INFO - 'SHELL': '/bin/bash', 20:45:47 INFO - 'SHLVL': '1', 20:45:47 INFO - 'TERM': 'linux', 20:45:47 INFO - 'TMOUT': '86400', 20:45:47 INFO - 'USER': 'cltbld', 20:45:47 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1479866219.899489-291600571', 20:45:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:47 INFO - '_': '/tools/buildbot/bin/python'} 20:45:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:45:48 INFO - Running setup.py (path:/tmp/pip-IJ_5Md-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:45:48 INFO - Running setup.py (path:/tmp/pip-dHRgnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:45:48 INFO - Running setup.py (path:/tmp/pip-6tJUUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:45:48 INFO - Running setup.py (path:/tmp/pip-fhBflS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:45:48 INFO - Running setup.py (path:/tmp/pip-IRvGgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:45:48 INFO - Running setup.py (path:/tmp/pip-9LY_FK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:45:48 INFO - Running setup.py (path:/tmp/pip-3t5eZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:45:48 INFO - Running setup.py (path:/tmp/pip-j9QRVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:45:48 INFO - Running setup.py (path:/tmp/pip-GdVEMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:45:48 INFO - Running setup.py (path:/tmp/pip-rfsObW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:45:48 INFO - Running setup.py (path:/tmp/pip-aiaHiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:45:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:45:48 INFO - Running setup.py (path:/tmp/pip-BGVqzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:45:49 INFO - Running setup.py (path:/tmp/pip-5PZUD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:45:49 INFO - Running setup.py (path:/tmp/pip-fnoJX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:45:49 INFO - Running setup.py (path:/tmp/pip-JdhwYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:45:49 INFO - Running setup.py (path:/tmp/pip-RMaO__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:45:49 INFO - Running setup.py (path:/tmp/pip-QiM0MW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:45:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:45:49 INFO - Running setup.py install for manifestparser 20:45:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:45:49 INFO - Running setup.py install for mozcrash 20:45:49 INFO - Running setup.py install for mozdebug 20:45:49 INFO - Running setup.py install for mozdevice 20:45:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:45:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:45:49 INFO - Running setup.py install for mozfile 20:45:49 INFO - Running setup.py install for mozhttpd 20:45:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:45:50 INFO - Running setup.py install for mozinfo 20:45:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:45:50 INFO - Running setup.py install for mozInstall 20:45:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:45:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:45:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:45:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:45:50 INFO - Running setup.py install for mozleak 20:45:50 INFO - Running setup.py install for mozlog 20:45:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:45:50 INFO - Running setup.py install for moznetwork 20:45:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:45:50 INFO - Running setup.py install for mozprocess 20:45:50 INFO - Running setup.py install for mozprofile 20:45:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:45:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:45:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:45:50 INFO - Running setup.py install for mozrunner 20:45:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:45:50 INFO - Running setup.py install for mozscreenshot 20:45:51 INFO - Running setup.py install for moztest 20:45:51 INFO - Running setup.py install for mozversion 20:45:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:45:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:45:51 INFO - Cleaning up... 20:45:51 INFO - Return code: 0 20:45:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:45:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:45:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:51 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 0x7f5132e31e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197c130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0afc0>, '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 0x1a0bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c350>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1479866219.899489-291600571', '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 20:45:51 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 20:45:51 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 20:45:51 INFO - Using env: {'DISPLAY': ':0', 20:45:51 INFO - 'HOME': '/home/cltbld', 20:45:51 INFO - 'LANG': 'en_US.UTF-8', 20:45:51 INFO - 'LANGUAGE': 'en_US:en', 20:45:51 INFO - 'LOGNAME': 'cltbld', 20:45:51 INFO - 'MAIL': '/var/mail/cltbld', 20:45:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:51 INFO - 'MOZ_NO_REMOTE': '1', 20:45:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:45:51 INFO - 'NO_EM_RESTART': '1', 20:45:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:45:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:51 INFO - 'PWD': '/builds/slave/test', 20:45:51 INFO - 'SHELL': '/bin/bash', 20:45:51 INFO - 'SHLVL': '1', 20:45:51 INFO - 'TERM': 'linux', 20:45:51 INFO - 'TMOUT': '86400', 20:45:51 INFO - 'USER': 'cltbld', 20:45:51 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1479866219.899489-291600571', 20:45:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:51 INFO - '_': '/tools/buildbot/bin/python'} 20:45:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:45:51 INFO - Running setup.py (path:/tmp/pip-35G_Um-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:45:51 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)) 20:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:45:51 INFO - Running setup.py (path:/tmp/pip-CcMwOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:45:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 20:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:45:51 INFO - Running setup.py (path:/tmp/pip-24tDj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:45:51 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)) 20:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:45:51 INFO - Running setup.py (path:/tmp/pip-9BPAsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:45:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 20:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:45:51 INFO - Running setup.py (path:/tmp/pip-SrO_rj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:45:51 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)) 20:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:45:51 INFO - Running setup.py (path:/tmp/pip-iCMWOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:45:51 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)) 20:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:45:51 INFO - Running setup.py (path:/tmp/pip-mkcGV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:45:51 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)) 20:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:45:51 INFO - Running setup.py (path:/tmp/pip-MMDq7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:45:52 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)) 20:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:45:52 INFO - Running setup.py (path:/tmp/pip-K6eo8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:45:52 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)) 20:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:45:52 INFO - Running setup.py (path:/tmp/pip-39VZu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:45:52 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)) 20:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:45:52 INFO - Running setup.py (path:/tmp/pip-d_3v_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:45:52 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)) 20:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:45:52 INFO - Running setup.py (path:/tmp/pip-q27f8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:45:52 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)) 20:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:45:52 INFO - Running setup.py (path:/tmp/pip-MafmFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:45:52 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)) 20:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:45:52 INFO - Running setup.py (path:/tmp/pip-TGorzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:45:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 20:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:45:52 INFO - Running setup.py (path:/tmp/pip-xMr7Vp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:45:52 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)) 20:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:45:52 INFO - Running setup.py (path:/tmp/pip-yvYYHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:45:52 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)) 20:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:45:52 INFO - Running setup.py (path:/tmp/pip-hX4yPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:45:52 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)) 20:45:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:45:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:45:52 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)) 20:45:52 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:45:52 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:45:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:45:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:45:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:45:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:45:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:45:54 INFO - Downloading blessings-1.6.tar.gz 20:45:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:45:54 INFO - Installing collected packages: blessings 20:45:54 INFO - Running setup.py install for blessings 20:45:54 INFO - Successfully installed blessings 20:45:54 INFO - Cleaning up... 20:45:54 INFO - Return code: 0 20:45:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:45:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:45:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:45:55 INFO - Reading from file tmpfile_stdout 20:45:55 INFO - Current package versions: 20:45:55 INFO - argparse == 1.2.1 20:45:55 INFO - blessings == 1.6 20:45:55 INFO - blobuploader == 1.2.4 20:45:55 INFO - docopt == 0.6.1 20:45:55 INFO - functools32 == 3.2.3-2 20:45:55 INFO - jsonschema == 2.5.1 20:45:55 INFO - manifestparser == 1.1 20:45:55 INFO - mozInstall == 1.12 20:45:55 INFO - mozcrash == 1.0 20:45:55 INFO - mozdebug == 0.1 20:45:55 INFO - mozdevice == 0.49 20:45:55 INFO - mozfile == 1.2 20:45:55 INFO - mozhttpd == 0.7 20:45:55 INFO - mozinfo == 0.9 20:45:55 INFO - mozleak == 0.1 20:45:55 INFO - mozlog == 3.4 20:45:55 INFO - moznetwork == 0.27 20:45:55 INFO - mozprocess == 0.23 20:45:55 INFO - mozprofile == 0.28 20:45:55 INFO - mozrunner == 6.13 20:45:55 INFO - mozscreenshot == 0.1 20:45:55 INFO - mozsystemmonitor == 0.3 20:45:55 INFO - moztest == 0.7 20:45:55 INFO - mozversion == 1.4 20:45:55 INFO - psutil == 3.1.1 20:45:55 INFO - requests == 1.2.3 20:45:55 INFO - wsgiref == 0.1.2 20:45:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:45:55 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')]} 20:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:55 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')]} 20:45:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:55 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 0x7f5132e31e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197c130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0afc0>, '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 0x1a0bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c350>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1479866219.899489-291600571', '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 20:45:55 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 20:45:55 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 20:45:55 INFO - Using env: {'DISPLAY': ':0', 20:45:55 INFO - 'HOME': '/home/cltbld', 20:45:55 INFO - 'LANG': 'en_US.UTF-8', 20:45:55 INFO - 'LANGUAGE': 'en_US:en', 20:45:55 INFO - 'LOGNAME': 'cltbld', 20:45:55 INFO - 'MAIL': '/var/mail/cltbld', 20:45:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:55 INFO - 'MOZ_NO_REMOTE': '1', 20:45:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:45:55 INFO - 'NO_EM_RESTART': '1', 20:45:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:45:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:55 INFO - 'PWD': '/builds/slave/test', 20:45:55 INFO - 'SHELL': '/bin/bash', 20:45:55 INFO - 'SHLVL': '1', 20:45:55 INFO - 'TERM': 'linux', 20:45:55 INFO - 'TMOUT': '86400', 20:45:55 INFO - 'USER': 'cltbld', 20:45:55 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1479866219.899489-291600571', 20:45:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:55 INFO - '_': '/tools/buildbot/bin/python'} 20:45:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:55 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)) 20:45:55 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)) 20:45:55 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)) 20:45:55 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)) 20:45:55 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)) 20:45:55 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)) 20:45:55 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)) 20:45:55 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)) 20:45:55 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)) 20:45:55 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)) 20:45:55 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)) 20:45:55 INFO - Cleaning up... 20:45:55 INFO - Return code: 0 20:45:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:45:55 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')]} 20:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:55 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')]} 20:45:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:55 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 0x7f5132e31e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e0b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x197c130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0afc0>, '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 0x1a0bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c350>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1479866219.899489-291600571', '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 20:45:55 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 20:45:55 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 20:45:55 INFO - Using env: {'DISPLAY': ':0', 20:45:55 INFO - 'HOME': '/home/cltbld', 20:45:55 INFO - 'LANG': 'en_US.UTF-8', 20:45:55 INFO - 'LANGUAGE': 'en_US:en', 20:45:55 INFO - 'LOGNAME': 'cltbld', 20:45:55 INFO - 'MAIL': '/var/mail/cltbld', 20:45:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:55 INFO - 'MOZ_NO_REMOTE': '1', 20:45:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:45:55 INFO - 'NO_EM_RESTART': '1', 20:45:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:45:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:55 INFO - 'PWD': '/builds/slave/test', 20:45:55 INFO - 'SHELL': '/bin/bash', 20:45:55 INFO - 'SHLVL': '1', 20:45:55 INFO - 'TERM': 'linux', 20:45:55 INFO - 'TMOUT': '86400', 20:45:55 INFO - 'USER': 'cltbld', 20:45:55 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1479866219.899489-291600571', 20:45:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:55 INFO - '_': '/tools/buildbot/bin/python'} 20:45:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:45:55 INFO - Cleaning up... 20:45:55 INFO - Return code: 0 20:45:55 INFO - Running post-action listener: _resource_record_post_action 20:45:55 INFO - Running post-action listener: _start_resource_monitoring 20:45:55 INFO - Starting resource monitoring. 20:45:55 INFO - [mozharness: 2016-11-23 04:45:55.576648Z] Finished create-virtualenv step (success) 20:45:55 INFO - [mozharness: 2016-11-23 04:45:55.577120Z] Running install step. 20:45:55 INFO - Running pre-action listener: _resource_record_pre_action 20:45:55 INFO - Running main action method: install 20:45:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:45:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:45:55 INFO - Reading from file tmpfile_stdout 20:45:55 INFO - Detecting whether we're running mozinstall >=1.0... 20:45:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:45:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:45:55 INFO - Reading from file tmpfile_stdout 20:45:55 INFO - Output received: 20:45:55 INFO - Usage: mozinstall [options] installer 20:45:55 INFO - Options: 20:45:55 INFO - -h, --help show this help message and exit 20:45:55 INFO - -d DEST, --destination=DEST 20:45:55 INFO - Directory to install application into. [default: 20:45:55 INFO - "/builds/slave/test"] 20:45:55 INFO - --app=APP Application being installed. [default: firefox] 20:45:55 INFO - mkdir: /builds/slave/test/build/application 20:45:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:45:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:46:11 INFO - Reading from file tmpfile_stdout 20:46:11 INFO - Output received: 20:46:11 INFO - /builds/slave/test/build/application/firefox/firefox 20:46:11 INFO - Running post-action listener: _resource_record_post_action 20:46:11 INFO - [mozharness: 2016-11-23 04:46:11.914704Z] Finished install step (success) 20:46:11 INFO - [mozharness: 2016-11-23 04:46:11.914945Z] Running run-tests step. 20:46:11 INFO - Running pre-action listener: _resource_record_pre_action 20:46:11 INFO - Running main action method: run_tests 20:46:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:46:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:46:11 INFO - Python 2.7.3 20:46:11 INFO - Return code: 0 20:46:11 INFO - grabbing minidump binary from tooltool 20:46:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:46:11 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 0x1a0afc0>, '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 0x1a0bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a0c350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:46:11 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 20:46:11 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 20:46:11 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 20:46:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:46:11 INFO - Return code: 0 20:46:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:46:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:46:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:46:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:46:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:46:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I_OESP6IS1e7eV12pm_KNQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 20:46:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I_OESP6IS1e7eV12pm_KNQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 20:46:11 INFO - Using env: {'DISPLAY': ':0', 20:46:11 INFO - 'HOME': '/home/cltbld', 20:46:11 INFO - 'LANG': 'en_US.UTF-8', 20:46:11 INFO - 'LANGUAGE': 'en_US:en', 20:46:11 INFO - 'LOGNAME': 'cltbld', 20:46:11 INFO - 'MAIL': '/var/mail/cltbld', 20:46:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:46:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:46:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:11 INFO - 'MOZ_NO_REMOTE': '1', 20:46:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:46:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:46:12 INFO - 'NO_EM_RESTART': '1', 20:46:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:46:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:12 INFO - 'PWD': '/builds/slave/test', 20:46:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:46:12 INFO - 'SHELL': '/bin/bash', 20:46:12 INFO - 'SHLVL': '1', 20:46:12 INFO - 'TERM': 'linux', 20:46:12 INFO - 'TMOUT': '86400', 20:46:12 INFO - 'USER': 'cltbld', 20:46:12 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1479866219.899489-291600571', 20:46:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:12 INFO - '_': '/tools/buildbot/bin/python'} 20:46:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I_OESP6IS1e7eV12pm_KNQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 20:46:12 INFO - mozversion application_buildid: 20161122192737 20:46:12 INFO - mozversion application_changeset: 90b691bf09f5cc4fe7d0c6445fcf5afa2c34eeee 20:46:12 INFO - mozversion application_display_name: Nightly 20:46:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:46:12 INFO - mozversion application_name: Firefox 20:46:12 INFO - mozversion application_remotingname: firefox 20:46:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:46:12 INFO - mozversion application_vendor: Mozilla 20:46:12 INFO - mozversion application_version: 53.0a1 20:46:12 INFO - mozversion platform_buildid: 20161122192737 20:46:12 INFO - mozversion platform_changeset: 90b691bf09f5cc4fe7d0c6445fcf5afa2c34eeee 20:46:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:46:12 INFO - mozversion platform_version: 53.0a1 20:46:12 INFO - using testdate: 1479876372 20:46:12 INFO - actual date: 1479876372 20:46:12 INFO - starting webserver on 'localhost:54296' 20:46:12 INFO - SUITE-START | Running 2 tests 20:46:12 INFO - TEST-START | dromaeo_css 20:46:12 INFO - operating with platform_type : linux_ 20:46:12 INFO - Initialising browser for dromaeo_css test... 20:46:12 INFO - TEST-INFO | started process 25026 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj6bCOa/profile http://localhost:54296/getInfo.html) 20:46:16 INFO - PROCESS | 25026 | __metrics Screen width/height:1600/1200 20:46:16 INFO - PROCESS | 25026 | colorDepth:24 20:46:16 INFO - PROCESS | 25026 | Browser inner width/height: 1024/697 20:46:16 INFO - PROCESS | 25026 | __metrics 20:46:17 INFO - PROCESS | 25026 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:46:17 INFO - PROCESS | 25026 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:46:17 INFO - PROCESS | 25026 | console.error: PushService: 20:46:17 INFO - PROCESS | 25026 | stateChangeProcessEnqueue: Error transitioning state 20:46:17 INFO - PROCESS | 25026 | UnknownError 20:46:18 INFO - TEST-INFO | 25026: exit 0 20:46:18 INFO - Browser initialized. 20:46:18 INFO - Running cycle 1/1 for dromaeo_css test... 20:46:18 INFO - TEST-INFO | started process 25111 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj6bCOa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:46:30 INFO - PROCESS | 25111 | RSS: Main: 173666304 20:46:30 INFO - PROCESS | 25111 | 20:47:22 INFO - PROCESS | 25111 | 1479876442040 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] 20:49:36 INFO - PROCESS | 25111 | Cycle 1(1): loaded http://localhost:54296/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54296/tests/dromaeo/cssquery-ext.html) 20:49:37 INFO - PROCESS | 25111 | RSS: Main: 313397248 20:49:37 INFO - PROCESS | 25111 | 20:52:40 INFO - PROCESS | 25111 | Cycle 1(1): loaded http://localhost:54296/tests/dromaeo/cssquery-ext.html (next: http://localhost:54296/tests/dromaeo/cssquery-jquery.html) 20:52:40 INFO - PROCESS | 25111 | RSS: Main: 288112640 20:52:40 INFO - PROCESS | 25111 | 20:55:43 INFO - PROCESS | 25111 | Cycle 1(1): loaded http://localhost:54296/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54296/tests/dromaeo/cssquery-mootools.html) 20:55:43 INFO - PROCESS | 25111 | RSS: Main: 221495296 20:55:43 INFO - PROCESS | 25111 | 20:58:46 INFO - PROCESS | 25111 | Cycle 1(1): loaded http://localhost:54296/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54296/tests/dromaeo/cssquery-prototype.html) 20:58:46 INFO - PROCESS | 25111 | RSS: Main: 244232192 20:58:46 INFO - PROCESS | 25111 | 21:01:49 INFO - PROCESS | 25111 | Cycle 1(1): loaded http://localhost:54296/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54296/tests/dromaeo/cssquery-yui.html) 21:01:50 INFO - PROCESS | 25111 | RSS: Main: 222470144 21:01:50 INFO - PROCESS | 25111 | 21:04:53 INFO - PROCESS | 25111 | Cycle 1(1): loaded http://localhost:54296/tests/dromaeo/cssquery-yui.html (next: http://localhost:54296/tests/dromaeo/cssquery-dojo.html) 21:04:53 INFO - PROCESS | 25111 | RSS: Main: 300339200 21:04:53 INFO - PROCESS | 25111 | 21:04:53 INFO - PROCESS | 25111 | __start_tp_report 21:04:53 INFO - PROCESS | 25111 | _x_x_mozilla_page_load 21:04:53 INFO - PROCESS | 25111 | _x_x_mozilla_page_load_details 21:04:53 INFO - PROCESS | 25111 | |i|pagename|runs| 21:04:53 INFO - PROCESS | 25111 | |0;dojo.html;2514.308565144585;2541.2757364151207;2549.3371723351925;2582.6384306197137;2595.351162209449;4572.748498832563;4625.884352891179;4652.418177819545;4674.20538508454;4702.459217190019;4652.883677908054;4665.533446655333;4674.672772905889;4676.812927482896;4688.648351373652;4244.660427165827;4270.103278311558;4277.037666525038;4303.440552728141;4309.396684464177;4369.73781573105;4373.037931655047;4389.846355377563;4417.050334178151;4418.624416924549;4331.610155086041;4366.126774645068;4390.67069969752;4392.758398288093;4413.4262545869;4396.582324679151;4433.756143412111;4435.290353543418;4438.201123797715;4473.709208901411;4216.746995180269;4271.466066741657;4271.743695378287;4346.565343465628;4349.717268377545;4668.603168730662;4673.369095172142;4685.086408150412;4686.742229177394;4757.738324392157;4991.50084991498;5020.0963826511215;5046.873828154289;5053;5080.5173508517;4902.558769710708;4951.306817045616;4961.404631444214;5065.518775716301;5118.129917913926;4694.389729335198;4740.644451666139;4759.6430267729365;4795.352627395257;4800.927986080212;5215.322008138994;5216.321878155892;5218.08683480397;5218.321618189611;5253.3958594761325;4977.352944117241;4988.575971042429;4989.5758860496535;4993.400791904922;5039.370078740158;4892.828750993769;4943.555080042814;4947.6289278304275;4987.102321582078;5071.771770270347;4894.461609222983;4936.925946110811;4952.2819191217795;4953.356063711766;4954.826581069645;4926.655134140576;4931.5561599455505;4934;4936.432310284292;4937.136001199848;4266.360045993064;4313.41768861206;4322.459692538433;4333.696641235147;4372.6939114261695;3727.440883867387;3751.512303400595;3787.715921305913;3817.2938006468894;3853.556840963269;4318.892027699333;4328.350747387917;4330.588594083557;4366.366876802909;4366.825326986885;4899.436564795023;4955.380577427822;4960.156773348539;5021.774020169101;5030.673006254582;4312;4323.0057086869565;4326.762028088486;4349.891252718644;4352.608265256142;4592.563706447949;4594.218982772936;4597.414390994746;4625.95374046262;4642.907141857144;4692.038132182963;4694.0377222668585;4698.201305777958;4729.36153619257;4741.620670346295;4948.257761335828;4994.575461085703;5000.374953130859;5034.395872495324;5060.2156665716875;4649.046945376257;4666.673332866667;4713.222318317439;4722.7874745635845;4739.526047395233;4947.356843610308;4957.975210123926;4961.950380496149;4963.354763880672;5009.899802003866;5001.799928002839;5026.648134630541;5045.394552653558;5047.369078865142;5080.898382032413;4744.169770290255;4750;4800.4479484859685;4841.370621819141;4929.433115191799;4849.660523763303;4900.681455705368;4930.82742104039;4939.5554400104165;4939.75301234944;4824.710517368969;4854.975725121351;4860.684055536379;4861.222204447272;4926.137925862888;4962.032403681247;4965.205567109245;4966.329545511454;4973.502649735142;5020.924686129784;4627.514111018295;4643.976780116078;4693.507181746004;4771.618270538418;4845.878853028703 21:04:53 INFO - PROCESS | 25111 | |1;ext.html;542.8832800947796;546.5054126015955;552.4227182594188;554.8585110796746;568.3662716071578;27343.316417089558;37313.626863731355;38306.61693383065;38422.039449013755;42474.15051698964;38504.807475962654;39138.60861391385;39220.21559568807;39274;39281.41077883827;7537.773866784005;7680.231976802331;7689.423293253;7690.65392057356;7695.807604809868;7542.396608271325;7619.390448764113;7624.885626715576;7628.0464941882265;7645.694172233132;7652.846943061136;7704.229577042307;7712.344450721667;7717.305442510173;7721.652525636332;7630.618469076552;7660.578668173248;7670.30967212948;7678.616069196546;7680.385569154454;7543.811404714871;7598.392128629696;7603.353714934237;7616.923830761677;7619.123800762873;36750.81624591887;37084.25831483382;37101.814490927645;37197.814010930044;37269.627303726884;3012.9548056778945;3037.104054303986;3053.221428535709;3241.6434192238835;3249.983750081258;25947.481050379076;26485;26956.865215673795;27110.058417841778;27291.590626140623;3403.23427228874;3439;3515.6660117288816;3639.399499082648;3645.65366290202;231706;231986;232122;232144;232719;48281.27578086332;48293.75853120782;48389.758051209516;48635.27047094297;48659.51340486621;50071.74964125229;50108.498915011114;50137;50143.24785128226;50149;13141.802872956914;13287.269200194081;14579.41682332716;14967.775483367759;14994.775078373834;10899.891001090045;11221.382823944597;11230.382328971822;11232.382218977871;11251.887481125248;18362.265509379744;18398.33224182486;18498.56034551725;18550.628987420176;18673;7152.713891444284;7327.74352897646;7389.194564799132;7411.370033547101;7427.689202220438;784.9058113026473;811.6307080278459;842.9662813487391;947.7444976505725;959.9568019439142;24481.265562033168;26451.603225951625;26846.060387886722;26900.32749181247;27019.86490067537;906.9274458043341;917.156216281023;937.3672770879765;956.063058202965;967.2455484721928;13263.602091937257;14298.213598251989;14462.132272063709;14505.347259373353;14566.63583410402;415871;424398;627171;628258;628715;46844;47386.289205661946;47398.5260147401;47420.288695669595;47427.762861185474;1079.5250089960393;1113.8440618313605;1159.628918746027;1193.8448001759716;1198.376844041111;24052.27843164708;27344.316392090357;29933.850330748206;30995.535066974466;31787.523187152674;43361.34957975696;44919.77540112279;45010.19959201595;51526.22710659268;51586;326983;332442;332476;332508.7985922241;334050;30989.421904056584;31750.841245793625;34977.30045399027;36438.63561364458;36699.44950825686;39046.609533904295;39228.607713922494;39361;40021.19957600773;40570.39144412895;32342.514862276614;32838.83580582177;32951;32967.91189894184;33316.33367332688;32020.51969220417;32541.511877321387;33206.418817901314;33538;33607.83196084004;32761.836190818893;33333;33384.49923251104;33494.497582536766;33964.49053264154;27581.724182758717;30515.694843051286;30631.54052689167;30656.540151897294;30883.11636450784;23469.41326466852;24052;24141.275761727175;24260.87869560641;24342 21:04:53 INFO - PROCESS | 25111 | |2;jquery.html;337.7909856364537;347.18065365736874;353.93452211340906;365.4937910993273;387.2274811750558;12497.43761530731;13528.255945922983;15554.688906221869;15961.521154365359;16734.16329183539;13531.323433828318;13712.314384280771;13713.3828977696;15310.311036003379;16415.589610259718;4843.225083986554;5087.592992560586;5090.363704536933;5095.923561146567;5097.006083813658;4662.114198302312;4991.376077990251;5014.874628134289;5019.247112933052;5022.874428139289;4981;4984.675996060245;4988.775505102279;4989.077020751154;5000.949990500085;4794.137055330022;4946.925796113025;4975.800967961313;4976.054549635558;4989.850304490871;4432.534583868712;4432.955670443319;4437.7781110944325;4438.467383913951;4439.400680908068;19002.42992710221;20218.696719549218;20422.5915481691;20423;20451;1809.6380723855282;1963.8527110466773;1984.4245168901002;2016.2842191022123;2404.4710163763943;12108.57619983305;12136.271823690518;12701.682457938534;13131.146475479063;13693;1656.1636373631238;1687.9071651059187;1695.4913525942168;1745.6595963787067;1747.318545767139;65568.3443165567;67544.32455675429;67963;68492.31507684909;69809.30190698079;9746.512674366253;9908;9986.30095893295;10239.48802559869;10494.737631559272;13239.139455935334;13260.668483287995;13336.733265334638;13373.53192638253;13375;7029.578225306498;7200.207977122513;7224.783256502314;7431.777046688608;7468.066491688539;7038.718451261892;7082.893756593655;7166.283371662792;7195.46034047438;7235.167955685059;4009.939850902239;4078;4186.769727664947;4308.353746937984;4421.977890110529;1743.1981288607383;1816.8546516278666;1836.8714190006572;1854.8887066776037;1880.4774517285675;667.8196886840526;798.8202654402713;815.7797394703515;888.4580405952364;903.439867282276;16112;16175.595610109842;16416.261268242957;16435.26041328143;17170.742438863428;805.1586092533316;826.5371392020488;853.5348235211825;880.0759202836996;893.7408151636083;8656.39405241627;9358.532073396304;9444.95277523608;9473.384230025027;9573.808523829484;352004;360463;364913;365285;366143;69524;70880.9119088087;71397.14136047254;72315.15272709135;73369;861.6036623153419;879.8856148700756;885.8272636835884;889.2086043421231;889.2574700125339;13789.448422063406;14905.925470372578;14915.254237287874;15178.468753593572;15364.385424582892;33877.83061084778;35105.978804238744;35580.04145632676;35650.46524302189;36519.63480365162;45890.770546147054;47869;48022.279665804344;48162;50521.74739126281;6428.517861160338;7368.557886526825;7473.476856619985;7571.886421703789;7989.520628762293;8551.273141783018;11812.881871181522;11926.642200733992;12319.815202771786;12331.75336493283;10217.386956782617;10300.587976481156;10474.162067034771;10642.308249963728;11048.558057677603;9646.372985755903;9676.516174191122;9752.268579856398;9764;10067.949660251652;10188.960716061662;10273.897261027294;10325.122364599094;10403.791924161626;10483.37099774016;6517.3808488193545;6614.140161778938;6642.302558231316;7067.2579379164445;7277.199508054004;8077.798055048671;9972.252081093802;10187.083162515113;10474.121788630247;10689.9465502672 21:04:53 INFO - PROCESS | 25111 | |3;mootools.html;1300.674831292177;1337.739140867531;1378.827646544182;1577.7317855964484;1604.5988502874275;6554.1479607651;7014.824629384268;7017.508774385782;7020.8946865796925;7021.1925628552735;5761.279840019997;5956.88086238275;6573.441257493118;6781.2201596816385;6854.931450685492;2036.4908772806798;2067.3074520035807;2076.345951025422;2077.1898959405767;2077.55332603491;2023.3120738948755;2048.4059622709397;2055.0341339570455;2071.140476702167;2075.4603803011173;1720.2087039961632;1779.9110044497788;1944.7860735319105;2003.9298624548144;2043.5810658814908;1989.254029738848;1991.7211590377215;1992.3425269661122;2000.5098750806073;2002.2391491233238;1976.505873531617;1978.8120128587761;2014.74815648044;2031.7968203179712;2033.4001469566513;6552.213734351861;6606.834829129262;6723.831904202385;6788.1175447191545;6788.694508747119;4138.52406973199;4267.0825772459075;4270.701050926436;4273.337632666941;4274.038341373197;2611.9477610447684;2778.5554311310298;2792.3437992071845;2822.3508593023516;2895.7104289570875;821.342925659476;855.3029281135854;862.8878245828065;878.8901387326584;881.5063564403954;8774.078721734253;8781.64873405063;8788.20906118446;8811.206991370744;8836.646534138627;3624.7462677612316;3736.0473079365133;3811.5045044144085;3815.0924537731134;3867.7099217558793;6518.445932095825;6796.558223715443;7727.227277272228;7735;7736.497127686683;4055.209234199303;4168.812403441852;4174.977130603022;4177.874663760092;4183.3515805050265;3909.5308562972627;3929.7249192556246;3950.6444420001762;3957.1294315250598;3961.3265744822875;2761.9585706214425;2813.1560531840364;2879.07869481768;2965.481040817848;2976.702329767006;842.8819965204876;843.7300063979468;847.0682249525472;855.6919508976763;855.8288342331558;643.5623775832386;771.5833449937084;783.0446854837089;793.8571057209758;831.4553967151526;4514.232580461329;4555.06621142665;4574.428196475441;4578.908421831611;4700.976495117503;388.14801510683776;389.41004378366796;394.936810110381;396.96824254059607;409.21226638720344;3110.7977981431136;3125.1093438369953;3194.4409728297455;3290.3254832759226;3361.2269178089177;7743.7676869694;8277.62750676221;8334.874976875351;8359.665613375397;8386.87419688705;8316.293115085286;8319.209675080858;8321.875171872305;8322.70870519541;8328.83342333162;6122.724477398528;6475.061116138134;6530.738770449128;6580.835479112965;6581.934180658132;4458.264386376211;4495.865124046284;4513.909721805479;4555.020670555847;4762.214234651382;7665.808354791175;7742.225777422213;7745.612719363897;7749.806254843674;7765.844683106419;7563.73526926577;7628.351590114902;7629.16079231273;7643;7779.844403112019;5650.971745141248;5764.394738552559;5777.364489906023;5782.884342313214;5788.0739081746715;6293.874122517615;6318.4313411793155;6396.456301214449;6498.675066246763;6536.182977127859;5747.1379293106365;5844.795432159854;5868.413158684098;5996.2504686914135;6053.848653783691;5779.711014449176;5887.116932460165;5903.793367232126;5915.053591425351;5967.701614919323;5392.649477783932;5458.918116228339;5506.311711036121;5515.062439385234;5529.529989950899;3994.281029414617;4035.6771458283856;4083.183363327406;4120.072983578671;4205.91588168241;3852.9807350963065;4004.3993400990084;4016.49793775778;4052.3313653246882;4146.460960075171 21:04:53 INFO - PROCESS | 25111 | |4;prototype.html;275.3748989793168;284.7949476377009;291.80011691990984;298.93274013347;300.84807172377947;4574.473935497419;4726.456457507387;4793.257045158001;4823.20417131173;4878.8780280493;4644.140833945714;4750.952490475102;4767.666263361557;4781.450133234679;4783.234682450809;3704.1850792825535;3729.552453705559;3734.4128745283283;3770.4344348347695;3772.8868133956025;3577.874774382897;3672.559292884844;3677.797721125337;3681.171736359311;3757.887263382103;3670.9816450917706;3748.868789592365;3776.3202623527754;3778.414345776409;3787.772733635991;3740.3080430120244;3741.906452338686;3751.1559899022773;3751.2872554214614;3752.3058234226755;3307.3881331953667;3307.4377355849565;3318.3197444523817;3321.0701003718755;3332.950005749916;4549.340345649895;4604.447466304032;4641.466231383367;4663.347131401607;4671.205894997858;4280.957190428087;4288.284686125544;4293.046663767978;4302.182585308781;4317.11499142675;4948.8472514456325;4958.429780575244;4959.504049595012;4978.676386034932;5012.223105418666;3348.648391918862;3511.2099777549847;3545.1461573433376;3566.5006899034156;3622.2031153146268;5188.8183913563225;5197.090509160882;5208.244804503326;5230.8169214077325;5241.344831896013;3612.1692010837655;3615.6745892869767;3623.166671665532;3630.8910732678064;3635.8909232723063;3462.9134271642906;3680.742348035612;3681.5950245472977;3681.9263614727556;3689.9262014759556;3935.4883865097927;4056.1684854604737;4060.4924384451942;4162.396452514429;4167.8332866685;4981.825636102792;4995.975824955875;5016.3446062799185;5045.823396181116;5056.974715126401;1219.1892391559513;1221.4930803716536;1222.5598784437595;1224.8731167326082;1229.84012078431;789.9249571290718;827.8344331133798;832.5171400587644;841.3017195727532;844.1980118887082;4314.633256173198;4317.287647538184;4347.891272732722;4358.891027724332;4367.497737760198;4988.351514303117;5015.172496538104;5024.221245706848;5042.546170844642;5061.240813877947;4268.186020941088;4278.893027674333;4281.529031806561;4355.303151495746;4370.628496577827;2445.7065152181854;2576.9098081567054;2622.396848724804;2624.8687565621644;2653.6152257922495;4589.33454649074;4608.170529304757;4639.979204574988;4663.603593694574;4689.365741550326;5070.873228169326;5093.2105523643895;5097.1844504879045;5107.9823469729245;5130.615203859726;4582.24392975162;4826.3243145958895;4835.879103022523;4843.39457567804;4893.681910675795;5203.531682148625;5215.765290561858;5220.660657057279;5244.76398562058;5258.447862974485;4942.418426103613;5105.463926287686;5172.172452407597;5172.870678233075;5174.97412512935;4796.472388037383;4840.564349208588;4868.2210846264425;4881.682690625098;4898.118338698926;3576.463530470346;3599.6940260078186;3609.9819500902327;3614.584322802911;3620.366435873764;4998.525140111684;5077.136886729339;5249.921251181312;5261.605379596469;5275.894482110413;4871.683340582851;4962.851114466572;5018.799248030038;5022.221555658879;5031.6729412588065;5008.873003574312;5013;5013.598912086952;5020.397552293748;5026.195808670595;4797.832075877328;4895.804167833389;4948.8762780930765;4960.77676504551;4989.25161225819;5025.321581586439;5036.647434679538;5038.445770965264;5044.646874718735;5045.394552653705;4915.8033678652455;4934.333864928332;4934.407871055496;4971.453140154653;4993.750312484434 21:04:53 INFO - PROCESS | 25111 | |5;yui.html;627.2567008095407;659.6916463933372;660.8050625065608;727.3308556128361;729.5695539631616;12066.457009434575;12740.362981850916;12744.80882786759;12769.233845969236;12770;11439.370834604093;11442.084633229342;11451.599194028211;11555.653330400102;11623.535058597647;612.3539665652735;626.8056902360283;728.5992704012798;739.3198257603004;753.4763339479064;745.6346390268784;760.6767123972318;761.0296871488869;761.4898018327706;761.7905076104088;807.1242701668697;809.2676128104075;809.5871105736088;809.7004108479841;809.76516810125;629.109809619388;644.255884453457;772.1853444615928;809.4333966223637;810;582.0512564519848;583.3262581718122;583.7781642975684;583.9708014599253;584.4914924016091;11319.547218111265;11341.943290283578;11375.089992800557;11379.14656400765;11423.371714555697;11527;11566.826497602542;11691.532338706442;11754.29474231549;11916.404179790976;9496.952515237448;9599.232061435068;9781.853272200922;9837;10803.459827008619;3993.4009898515164;4012.0772222388723;4015.0966032642714;4030;4042.2521833460905;46851;47531.28703069422;47607.52392476066;48714.512854871355;49123.50876491225;9583.233341332676;9622.182114520205;9731.708048758548;9805.509724513888;9828.557714902847;16358.345666173458;16394.1802909854;16397;16464.341426342813;16550.089745063895;6227.719752611143;6298.685065746694;6299.181106456132;6425.293217746044;6551.541392102602;3421.674940880612;3459.9481007784902;3573.3746594345885;3578.6958108561066;3679.411294192916;2421.830471866988;2497.4006238502993;2507.2227609440765;2659.946801063968;2788.177487641151;499.28851386773704;500.2696063746898;511.12342332898515;511.1719015195333;522.0186050225552;495.63075508745493;600.7326739600923;606.5269090109722;610.920580324555;624.8346833156131;7501.887471687929;7513.2862378074;7565.167831538526;7900.367970562456;7982.481138725964;460.2176300289521;519.8752299448105;521.8773588206768;533.9733013349316;565.5249590344131;3685.0418891087975;3715.64701353371;3723.6727045596504;3746.7377283589885;3918.0988372674447;42835.78582107132;43196.78401607972;43234.351484727755;62788.744225116156;74719;62432.68783656053;62534.37465625376;62771.37228627747;62863.68568157221;62951;44499.33251001238;46862;50440.24339634835;50660.74669626628;50750;8134.722277762236;8445;8548.700795472128;8615.48307101551;8654.264387527131;25461;32301.838490807397;34073.31853362968;34959.65040349564;35689.82155089208;36380.454293185096;47426.76286618545;47792.283115752594;47919;48189;10276.280660353703;10294.485275736333;10388.636397726043;10421.06210441064;10522.736931576772;11628.592999244986;11986;12000.699982500508;12072.698182545506;12799.168054076456;10987.890121098686;11150.519631057048;11305.7738845221;11366.147538934447;11869.40652967331;10902.945485272523;11015.063719583604;11258.211925165488;11921.46353414081;11947.223430476992;10592.682219533426;10885.238033337908;10887.564497420015;10973.451327433757;11585.246958947642;8681.652733890574;8903.19871211594;9168;9355.158035776813;9403.247740180632;8981.326400519856;9242.537873106452;9364.672236471692;9406.717798466058;9421.340506164503 21:04:53 INFO - PROCESS | 25111 | __end_tp_report 21:04:53 INFO - PROCESS | 25111 | __start_cc_report 21:04:53 INFO - PROCESS | 25111 | _x_x_mozilla_cycle_collect,1419 21:04:53 INFO - PROCESS | 25111 | __end_cc_report 21:04:53 INFO - PROCESS | 25111 | __startTimestamp1479877493870__endTimestamp 21:04:53 INFO - PROCESS | 25111 | 21:04:53 INFO - PROCESS | 25111 | ------- Summary: start ------- 21:04:53 INFO - PROCESS | 25111 | Number of tests: 6 21:04:53 INFO - PROCESS | 25111 | 21:04:53 INFO - PROCESS | 25111 | [#0] dojo.html Cycles:165 Average:4645.01 Median:4740.64 stddev:483.76 (10.2%) stddev-sans-first:455.46 21:04:53 INFO - PROCESS | 25111 | Values: 2514.3 2541.3 2549.3 2582.6 2595.4 4572.7 4625.9 4652.4 4674.2 4702.5 4652.9 4665.5 4674.7 4676.8 4688.6 4244.7 4270.1 4277.0 4303.4 4309.4 4369.7 4373.0 4389.8 4417.1 4418.6 4331.6 4366.1 4390.7 4392.8 4413.4 4396.6 4433.8 4435.3 4438.2 4473.7 4216.7 4271.5 4271.7 4346.6 4349.7 4668.6 4673.4 4685.1 4686.7 4757.7 4991.5 5020.1 5046.9 5053.0 5080.5 4902.6 4951.3 4961.4 5065.5 5118.1 4694.4 4740.6 4759.6 4795.4 4800.9 5215.3 5216.3 5218.1 5218.3 5253.4 4977.4 4988.6 4989.6 4993.4 5039.4 4892.8 4943.6 4947.6 4987.1 5071.8 4894.5 4936.9 4952.3 4953.4 4954.8 4926.7 4931.6 4934.0 4936.4 4937.1 4266.4 4313.4 4322.5 4333.7 4372.7 3727.4 3751.5 3787.7 3817.3 3853.6 4318.9 4328.4 4330.6 4366.4 4366.8 4899.4 4955.4 4960.2 5021.8 5030.7 4312.0 4323.0 4326.8 4349.9 4352.6 4592.6 4594.2 4597.4 4626.0 4642.9 4692.0 4694.0 4698.2 4729.4 4741.6 4948.3 4994.6 5000.4 5034.4 5060.2 4649.0 4666.7 4713.2 4722.8 4739.5 4947.4 4958.0 4962.0 4963.4 5009.9 5001.8 5026.6 5045.4 5047.4 5080.9 4744.2 4750.0 4800.4 4841.4 4929.4 4849.7 4900.7 4930.8 4939.6 4939.8 4824.7 4855.0 4860.7 4861.2 4926.1 4962.0 4965.2 4966.3 4973.5 5020.9 4627.5 4644.0 4693.5 4771.6 4845.9 21:04:53 INFO - PROCESS | 25111 | 21:04:53 INFO - PROCESS | 25111 | [#1] ext.html Cycles:180 Average:51047.29 Median:36725.13 stddev:105968.93 (288.5%) stddev-sans-first:106198.36 21:04:53 INFO - PROCESS | 25111 | Values: 542.9 546.5 552.4 554.9 568.4 27343.3 37313.6 38306.6 38422.0 42474.2 38504.8 39138.6 39220.2 39274.0 39281.4 7537.8 7680.2 7689.4 7690.7 7695.8 7542.4 7619.4 7624.9 7628.0 7645.7 7652.8 7704.2 7712.3 7717.3 7721.7 7630.6 7660.6 7670.3 7678.6 7680.4 7543.8 7598.4 7603.4 7616.9 7619.1 36750.8 37084.3 37101.8 37197.8 37269.6 3013.0 3037.1 3053.2 3241.6 3250.0 25947.5 26485.0 26956.9 27110.1 27291.6 3403.2 3439.0 3515.7 3639.4 3645.7 231706.0 231986.0 232122.0 232144.0 232719.0 48281.3 48293.8 48389.8 48635.3 48659.5 50071.7 50108.5 50137.0 50143.2 50149.0 13141.8 13287.3 14579.4 14967.8 14994.8 10899.9 11221.4 11230.4 11232.4 11251.9 18362.3 18398.3 18498.6 18550.6 18673.0 7152.7 7327.7 7389.2 7411.4 7427.7 784.9 811.6 843.0 947.7 960.0 24481.3 26451.6 26846.1 26900.3 27019.9 906.9 917.2 937.4 956.1 967.2 13263.6 14298.2 14462.1 14505.3 14566.6 415871.0 424398.0 627171.0 628258.0 628715.0 46844.0 47386.3 47398.5 47420.3 47427.8 1079.5 1113.8 1159.6 1193.8 1198.4 24052.3 27344.3 29933.9 30995.5 31787.5 43361.3 44919.8 45010.2 51526.2 51586.0 326983.0 332442.0 332476.0 332508.8 334050.0 30989.4 31750.8 34977.3 36438.6 36699.4 39046.6 39228.6 39361.0 40021.2 40570.4 32342.5 32838.8 32951.0 32967.9 33316.3 32020.5 32541.5 33206.4 33538.0 33607.8 32761.8 33333.0 33384.5 33494.5 33964.5 27581.7 30515.7 30631.5 30656.5 30883.1 23469.4 24052.0 24141.3 24260.9 24342.0 21:04:53 INFO - PROCESS | 25111 | 21:04:53 INFO - PROCESS | 25111 | [#2] jquery.html Cycles:180 Average:23009.96 Median:4432.75 stddev:59767.91 (1348.3%) stddev-sans-first:59911.33 21:04:53 INFO - PROCESS | 25111 | Values: 337.8 347.2 353.9 365.5 387.2 12497.4 13528.3 15554.7 15961.5 16734.2 13531.3 13712.3 13713.4 15310.3 16415.6 4843.2 5087.6 5090.4 5095.9 5097.0 4662.1 4991.4 5014.9 5019.2 5022.9 4981.0 4984.7 4988.8 4989.1 5000.9 4794.1 4946.9 4975.8 4976.1 4989.9 4432.5 4433.0 4437.8 4438.5 4439.4 19002.4 20218.7 20422.6 20423.0 20451.0 1809.6 1963.9 1984.4 2016.3 2404.5 12108.6 12136.3 12701.7 13131.1 13693.0 1656.2 1687.9 1695.5 1745.7 1747.3 65568.3 67544.3 67963.0 68492.3 69809.3 9746.5 9908.0 9986.3 10239.5 10494.7 13239.1 13260.7 13336.7 13373.5 13375.0 7029.6 7200.2 7224.8 7431.8 7468.1 7038.7 7082.9 7166.3 7195.5 7235.2 4009.9 4078.0 4186.8 4308.4 4422.0 1743.2 1816.9 1836.9 1854.9 1880.5 667.8 798.8 815.8 888.5 903.4 16112.0 16175.6 16416.3 16435.3 17170.7 805.2 826.5 853.5 880.1 893.7 8656.4 9358.5 9445.0 9473.4 9573.8 352004.0 360463.0 364913.0 365285.0 366143.0 69524.0 70880.9 71397.1 72315.2 73369.0 861.6 879.9 885.8 889.2 889.3 13789.4 14905.9 14915.3 15178.5 15364.4 33877.8 35106.0 35580.0 35650.5 36519.6 45890.8 47869.0 48022.3 48162.0 50521.7 6428.5 7368.6 7473.5 7571.9 7989.5 8551.3 11812.9 11926.6 12319.8 12331.8 10217.4 10300.6 10474.2 10642.3 11048.6 9646.4 9676.5 9752.3 9764.0 10067.9 10189.0 10273.9 10325.1 10403.8 10483.4 6517.4 6614.1 6642.3 7067.3 7277.2 8077.8 9972.3 10187.1 10474.1 10689.9 21:04:53 INFO - PROCESS | 25111 | 21:04:53 INFO - PROCESS | 25111 | [#3] mootools.html Cycles:180 Average:4457.88 Median:5425.78 stddev:2425.26 (44.7%) stddev-sans-first:2420.46 21:04:53 INFO - PROCESS | 25111 | Values: 1300.7 1337.7 1378.8 1577.7 1604.6 6554.1 7014.8 7017.5 7020.9 7021.2 5761.3 5956.9 6573.4 6781.2 6854.9 2036.5 2067.3 2076.3 2077.2 2077.6 2023.3 2048.4 2055.0 2071.1 2075.5 1720.2 1779.9 1944.8 2003.9 2043.6 1989.3 1991.7 1992.3 2000.5 2002.2 1976.5 1978.8 2014.7 2031.8 2033.4 6552.2 6606.8 6723.8 6788.1 6788.7 4138.5 4267.1 4270.7 4273.3 4274.0 2611.9 2778.6 2792.3 2822.4 2895.7 821.3 855.3 862.9 878.9 881.5 8774.1 8781.6 8788.2 8811.2 8836.6 3624.7 3736.0 3811.5 3815.1 3867.7 6518.4 6796.6 7727.2 7735.0 7736.5 4055.2 4168.8 4175.0 4177.9 4183.4 3909.5 3929.7 3950.6 3957.1 3961.3 2762.0 2813.2 2879.1 2965.5 2976.7 842.9 843.7 847.1 855.7 855.8 643.6 771.6 783.0 793.9 831.5 4514.2 4555.1 4574.4 4578.9 4701.0 388.1 389.4 394.9 397.0 409.2 3110.8 3125.1 3194.4 3290.3 3361.2 7743.8 8277.6 8334.9 8359.7 8386.9 8316.3 8319.2 8321.9 8322.7 8328.8 6122.7 6475.1 6530.7 6580.8 6581.9 4458.3 4495.9 4513.9 4555.0 4762.2 7665.8 7742.2 7745.6 7749.8 7765.8 7563.7 7628.4 7629.2 7643.0 7779.8 5651.0 5764.4 5777.4 5782.9 5788.1 6293.9 6318.4 6396.5 6498.7 6536.2 5747.1 5844.8 5868.4 5996.3 6053.8 5779.7 5887.1 5903.8 5915.1 5967.7 5392.6 5458.9 5506.3 5515.1 5529.5 3994.3 4035.7 4083.2 4120.1 4205.9 3853.0 4004.4 4016.5 4052.3 4146.5 21:04:53 INFO - PROCESS | 25111 | 21:04:53 INFO - PROCESS | 25111 | [#4] prototype.html Cycles:180 Average:4131.71 Median:4667.40 stddev:1213.41 (26.0%) stddev-sans-first:1181.78 21:04:53 INFO - PROCESS | 25111 | Values: 275.4 284.8 291.8 298.9 300.8 4574.5 4726.5 4793.3 4823.2 4878.9 4644.1 4751.0 4767.7 4781.5 4783.2 3704.2 3729.6 3734.4 3770.4 3772.9 3577.9 3672.6 3677.8 3681.2 3757.9 3671.0 3748.9 3776.3 3778.4 3787.8 3740.3 3741.9 3751.2 3751.3 3752.3 3307.4 3307.4 3318.3 3321.1 3333.0 4549.3 4604.4 4641.5 4663.3 4671.2 4281.0 4288.3 4293.0 4302.2 4317.1 4948.8 4958.4 4959.5 4978.7 5012.2 3348.6 3511.2 3545.1 3566.5 3622.2 5188.8 5197.1 5208.2 5230.8 5241.3 3612.2 3615.7 3623.2 3630.9 3635.9 3462.9 3680.7 3681.6 3681.9 3689.9 3935.5 4056.2 4060.5 4162.4 4167.8 4981.8 4996.0 5016.3 5045.8 5057.0 1219.2 1221.5 1222.6 1224.9 1229.8 789.9 827.8 832.5 841.3 844.2 4314.6 4317.3 4347.9 4358.9 4367.5 4988.4 5015.2 5024.2 5042.5 5061.2 4268.2 4278.9 4281.5 4355.3 4370.6 2445.7 2576.9 2622.4 2624.9 2653.6 4589.3 4608.2 4640.0 4663.6 4689.4 5070.9 5093.2 5097.2 5108.0 5130.6 4582.2 4826.3 4835.9 4843.4 4893.7 5203.5 5215.8 5220.7 5244.8 5258.4 4942.4 5105.5 5172.2 5172.9 5175.0 4796.5 4840.6 4868.2 4881.7 4898.1 3576.5 3599.7 3610.0 3614.6 3620.4 4998.5 5077.1 5249.9 5261.6 5275.9 4871.7 4962.9 5018.8 5022.2 5031.7 5008.9 5013.0 5013.6 5020.4 5026.2 4797.8 4895.8 4948.9 4960.8 4989.3 5025.3 5036.6 5038.4 5044.6 5045.4 4915.8 4934.3 4934.4 4971.5 4993.8 21:04:53 INFO - PROCESS | 25111 | 21:04:53 INFO - PROCESS | 25111 | [#5] yui.html Cycles:180 Average:13634.34 Median:48919.01 stddev:16835.24 (34.4%) stddev-sans-first:16854.14 21:04:53 INFO - PROCESS | 25111 | Values: 627.3 659.7 660.8 727.3 729.6 12066.5 12740.4 12744.8 12769.2 12770.0 11439.4 11442.1 11451.6 11555.7 11623.5 612.4 626.8 728.6 739.3 753.5 745.6 760.7 761.0 761.5 761.8 807.1 809.3 809.6 809.7 809.8 629.1 644.3 772.2 809.4 810.0 582.1 583.3 583.8 584.0 584.5 11319.5 11341.9 11375.1 11379.1 11423.4 11527.0 11566.8 11691.5 11754.3 11916.4 9497.0 9599.2 9781.9 9837.0 10803.5 3993.4 4012.1 4015.1 4030.0 4042.3 46851.0 47531.3 47607.5 48714.5 49123.5 9583.2 9622.2 9731.7 9805.5 9828.6 16358.3 16394.2 16397.0 16464.3 16550.1 6227.7 6298.7 6299.2 6425.3 6551.5 3421.7 3459.9 3573.4 3578.7 3679.4 2421.8 2497.4 2507.2 2659.9 2788.2 499.3 500.3 511.1 511.2 522.0 495.6 600.7 606.5 610.9 624.8 7501.9 7513.3 7565.2 7900.4 7982.5 460.2 519.9 521.9 534.0 565.5 3685.0 3715.6 3723.7 3746.7 3918.1 42835.8 43196.8 43234.4 62788.7 74719.0 62432.7 62534.4 62771.4 62863.7 62951.0 44499.3 46862.0 50440.2 50660.7 50750.0 8134.7 8445.0 8548.7 8615.5 8654.3 25461.0 32301.8 34073.3 34959.7 35689.8 36380.5 47426.8 47792.3 47919.0 48189.0 10276.3 10294.5 10388.6 10421.1 10522.7 11628.6 11986.0 12000.7 12072.7 12799.2 10987.9 11150.5 11305.8 11366.1 11869.4 10902.9 11015.1 11258.2 11921.5 11947.2 10592.7 10885.2 10887.6 10973.5 11585.2 8681.7 8903.2 9168.0 9355.2 9403.2 8981.3 9242.5 9364.7 9406.7 9421.3 21:04:53 INFO - PROCESS | 25111 | -------- Summary: end -------- 21:04:53 INFO - PROCESS | 25111 | 21:04:54 INFO - TEST-INFO | 25111: exit 0 21:04:54 INFO - TEST-OK | dromaeo_css | took 1122650ms 21:04:54 INFO - TEST-START | kraken 21:04:54 INFO - operating with platform_type : linux_ 21:04:54 INFO - Initialising browser for kraken test... 21:04:54 INFO - TEST-INFO | started process 25415 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDeWkDu/profile http://localhost:54296/getInfo.html) 21:04:59 INFO - PROCESS | 25415 | __metrics Screen width/height:1600/1200 21:04:59 INFO - PROCESS | 25415 | colorDepth:24 21:04:59 INFO - PROCESS | 25415 | Browser inner width/height: 1024/697 21:04:59 INFO - PROCESS | 25415 | __metrics 21:04:59 INFO - PROCESS | 25415 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:04:59 INFO - PROCESS | 25415 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:05:00 INFO - PROCESS | 25415 | console.error: PushService: 21:05:00 INFO - PROCESS | 25415 | stateChangeProcessEnqueue: Error transitioning state 21:05:00 INFO - PROCESS | 25415 | UnknownError 21:05:01 INFO - TEST-INFO | 25415: exit 0 21:05:01 INFO - Browser initialized. 21:05:01 INFO - Running cycle 1/1 for kraken test... 21:05:01 INFO - TEST-INFO | started process 25500 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDeWkDu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:05:13 INFO - PROCESS | 25500 | RSS: Main: 173719552 21:05:13 INFO - PROCESS | 25500 | 21:05:16 INFO - PROCESS | 25500 | Cycle 1(1): loaded http://localhost:54296/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54296/tests/kraken/driver.html?testName=audio-beat-detection) 21:05:17 INFO - PROCESS | 25500 | RSS: Main: 230768640 21:05:17 INFO - PROCESS | 25500 | 21:05:19 INFO - PROCESS | 25500 | Cycle 1(1): loaded http://localhost:54296/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54296/tests/kraken/driver.html?testName=audio-dft) 21:05:20 INFO - PROCESS | 25500 | RSS: Main: 217911296 21:05:20 INFO - PROCESS | 25500 | 21:05:23 INFO - PROCESS | 25500 | Cycle 1(1): loaded http://localhost:54296/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54296/tests/kraken/driver.html?testName=audio-fft) 21:05:24 INFO - PROCESS | 25500 | RSS: Main: 299413504 21:05:24 INFO - PROCESS | 25500 | 21:05:26 INFO - PROCESS | 25500 | Cycle 1(1): loaded http://localhost:54296/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54296/tests/kraken/driver.html?testName=audio-oscillator) 21:05:27 INFO - PROCESS | 25500 | RSS: Main: 210374656 21:05:27 INFO - PROCESS | 25500 | 21:05:29 INFO - PROCESS | 25500 | Cycle 1(1): loaded http://localhost:54296/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54296/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:05:29 INFO - PROCESS | 25500 | RSS: Main: 213475328 21:05:29 INFO - PROCESS | 25500 | 21:05:33 INFO - PROCESS | 25500 | Cycle 1(1): loaded http://localhost:54296/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54296/tests/kraken/driver.html?testName=imaging-darkroom) 21:05:33 INFO - PROCESS | 25500 | RSS: Main: 253497344 21:05:33 INFO - PROCESS | 25500 | 21:05:37 INFO - PROCESS | 25500 | Cycle 1(1): loaded http://localhost:54296/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54296/tests/kraken/driver.html?testName=imaging-desaturate) 21:05:37 INFO - PROCESS | 25500 | RSS: Main: 253419520 21:05:37 INFO - PROCESS | 25500 | 21:05:40 INFO - PROCESS | 25500 | Cycle 1(1): loaded http://localhost:54296/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54296/tests/kraken/driver.html?testName=json-parse-financial) 21:05:41 INFO - PROCESS | 25500 | RSS: Main: 251928576 21:05:41 INFO - PROCESS | 25500 | 21:05:43 INFO - PROCESS | 25500 | Cycle 1(1): loaded http://localhost:54296/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54296/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:05:43 INFO - PROCESS | 25500 | RSS: Main: 214405120 21:05:43 INFO - PROCESS | 25500 | 21:05:45 INFO - PROCESS | 25500 | Cycle 1(1): loaded http://localhost:54296/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54296/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:05:46 INFO - PROCESS | 25500 | RSS: Main: 221204480 21:05:46 INFO - PROCESS | 25500 | 21:05:48 INFO - PROCESS | 25500 | Cycle 1(1): loaded http://localhost:54296/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54296/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:05:49 INFO - PROCESS | 25500 | RSS: Main: 229756928 21:05:49 INFO - PROCESS | 25500 | 21:05:51 INFO - PROCESS | 25500 | Cycle 1(1): loaded http://localhost:54296/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54296/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:05:52 INFO - PROCESS | 25500 | RSS: Main: 238276608 21:05:52 INFO - PROCESS | 25500 | 21:05:55 INFO - PROCESS | 25500 | Cycle 1(1): loaded http://localhost:54296/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54296/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:05:56 INFO - PROCESS | 25500 | RSS: Main: 235270144 21:05:56 INFO - PROCESS | 25500 | 21:05:58 INFO - PROCESS | 25500 | Cycle 1(1): loaded http://localhost:54296/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54296/tests/kraken/driver.html?testName=ai-astar) 21:05:58 INFO - PROCESS | 25500 | RSS: Main: 284639232 21:05:58 INFO - PROCESS | 25500 | 21:05:58 INFO - PROCESS | 25500 | __start_tp_report 21:05:58 INFO - PROCESS | 25500 | _x_x_mozilla_page_load 21:05:58 INFO - PROCESS | 25500 | _x_x_mozilla_page_load_details 21:05:58 INFO - PROCESS | 25500 | |i|pagename|runs| 21:05:58 INFO - PROCESS | 25500 | |0;ai-astar;110;115;117;117;116;117;116;115;116;116 21:05:58 INFO - PROCESS | 25500 | |1;audio-beat-detection;162;130;132;176;136;131;131;132;167;130 21:05:58 INFO - PROCESS | 25500 | |2;audio-dft;161;161;162;162;161;164;160;161;160;164 21:05:58 INFO - PROCESS | 25500 | |3;audio-fft;76;79;77;119;79;77;76;77;102;76 21:05:58 INFO - PROCESS | 25500 | |4;audio-oscillator;84;84;114;83;83;84;105;83;84;115 21:05:58 INFO - PROCESS | 25500 | |5;imaging-gaussian-blur;116;117;117;117;116;116;117;117;117;117 21:05:58 INFO - PROCESS | 25500 | |6;imaging-darkroom;147;148;149;146;146;146;146;147;146;146 21:05:58 INFO - PROCESS | 25500 | |7;imaging-desaturate;95;96;96;95;96;95;96;96;95;95 21:05:58 INFO - PROCESS | 25500 | |8;json-parse-financial;66;65;65;67;66;66;65;66;66;72 21:05:58 INFO - PROCESS | 25500 | |9;json-stringify-tinderbox;66;66;66;67;68;67;67;67;68;67 21:05:58 INFO - PROCESS | 25500 | |10;stanford-crypto-aes;87;90;92;86;95;86;86;94;85;85 21:05:58 INFO - PROCESS | 25500 | |11;stanford-crypto-ccm;155;148;141;150;152;146;157;152;181;146 21:05:58 INFO - PROCESS | 25500 | |12;stanford-crypto-pbkdf2;185;180;180;181;177;180;179;179;180;177 21:05:58 INFO - PROCESS | 25500 | |13;stanford-crypto-sha256-iterative;70;70;70;69;70;70;68;68;69;68 21:05:58 INFO - PROCESS | 25500 | __end_tp_report 21:05:58 INFO - PROCESS | 25500 | __start_cc_report 21:05:58 INFO - PROCESS | 25500 | _x_x_mozilla_cycle_collect,1972 21:05:58 INFO - PROCESS | 25500 | __end_cc_report 21:05:58 INFO - PROCESS | 25500 | __startTimestamp1479877558396__endTimestamp 21:05:58 INFO - PROCESS | 25500 | 21:05:58 INFO - PROCESS | 25500 | ------- Summary: start ------- 21:05:58 INFO - PROCESS | 25500 | Number of tests: 14 21:05:58 INFO - PROCESS | 25500 | 21:05:58 INFO - PROCESS | 25500 | [#0] ai-astar Cycles:10 Average:115.50 Median:116.00 stddev:2.07 (1.8%) stddev-sans-first:0.78 21:05:58 INFO - PROCESS | 25500 | Values: 110.0 115.0 117.0 117.0 116.0 117.0 116.0 115.0 116.0 116.0 21:05:58 INFO - PROCESS | 25500 | 21:05:58 INFO - PROCESS | 25500 | [#1] audio-beat-detection Cycles:10 Average:142.70 Median:134.00 stddev:18.08 (13.5%) stddev-sans-first:17.78 21:05:58 INFO - PROCESS | 25500 | Values: 162.0 130.0 132.0 176.0 136.0 131.0 131.0 132.0 167.0 130.0 21:05:58 INFO - PROCESS | 25500 | 21:05:58 INFO - PROCESS | 25500 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:1.43 (0.9%) stddev-sans-first:1.50 21:05:58 INFO - PROCESS | 25500 | Values: 161.0 161.0 162.0 162.0 161.0 164.0 160.0 161.0 160.0 164.0 21:05:58 INFO - PROCESS | 25500 | 21:05:58 INFO - PROCESS | 25500 | [#3] audio-fft Cycles:10 Average:83.80 Median:77.00 stddev:14.67 (19.1%) stddev-sans-first:15.29 21:05:58 INFO - PROCESS | 25500 | Values: 76.0 79.0 77.0 119.0 79.0 77.0 76.0 77.0 102.0 76.0 21:05:58 INFO - PROCESS | 25500 | 21:05:58 INFO - PROCESS | 25500 | [#4] audio-oscillator Cycles:10 Average:91.90 Median:83.50 stddev:13.67 (16.4%) stddev-sans-first:14.19 21:05:58 INFO - PROCESS | 25500 | Values: 84.0 84.0 114.0 83.0 83.0 84.0 105.0 83.0 84.0 115.0 21:05:58 INFO - PROCESS | 25500 | 21:05:58 INFO - PROCESS | 25500 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 21:05:58 INFO - PROCESS | 25500 | Values: 116.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 21:05:58 INFO - PROCESS | 25500 | 21:05:58 INFO - PROCESS | 25500 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:146.50 stddev:1.06 (0.7%) stddev-sans-first:1.12 21:05:58 INFO - PROCESS | 25500 | Values: 147.0 148.0 149.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 21:05:58 INFO - PROCESS | 25500 | 21:05:58 INFO - PROCESS | 25500 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 21:05:58 INFO - PROCESS | 25500 | Values: 95.0 96.0 96.0 95.0 96.0 95.0 96.0 96.0 95.0 95.0 21:05:58 INFO - PROCESS | 25500 | 21:05:58 INFO - PROCESS | 25500 | [#8] json-parse-financial Cycles:10 Average:66.40 Median:66.00 stddev:2.07 (3.1%) stddev-sans-first:2.19 21:05:58 INFO - PROCESS | 25500 | Values: 66.0 65.0 65.0 67.0 66.0 66.0 65.0 66.0 66.0 72.0 21:05:58 INFO - PROCESS | 25500 | 21:05:58 INFO - PROCESS | 25500 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:67.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 21:05:58 INFO - PROCESS | 25500 | Values: 66.0 66.0 66.0 67.0 68.0 67.0 67.0 67.0 68.0 67.0 21:05:58 INFO - PROCESS | 25500 | 21:05:58 INFO - PROCESS | 25500 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:88.50 stddev:3.84 (4.3%) stddev-sans-first:4.02 21:05:58 INFO - PROCESS | 25500 | Values: 87.0 90.0 92.0 86.0 95.0 86.0 86.0 94.0 85.0 85.0 21:05:58 INFO - PROCESS | 25500 | 21:05:58 INFO - PROCESS | 25500 | [#11] stanford-crypto-ccm Cycles:10 Average:152.80 Median:152.00 stddev:10.96 (7.2%) stddev-sans-first:11.60 21:05:58 INFO - PROCESS | 25500 | Values: 155.0 148.0 141.0 150.0 152.0 146.0 157.0 152.0 181.0 146.0 21:05:58 INFO - PROCESS | 25500 | 21:05:58 INFO - PROCESS | 25500 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.80 Median:180.00 stddev:2.25 (1.3%) stddev-sans-first:1.39 21:05:58 INFO - PROCESS | 25500 | Values: 185.0 180.0 180.0 181.0 177.0 180.0 179.0 179.0 180.0 177.0 21:05:58 INFO - PROCESS | 25500 | 21:05:58 INFO - PROCESS | 25500 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:70.00 stddev:0.92 (1.3%) stddev-sans-first:0.93 21:05:58 INFO - PROCESS | 25500 | Values: 70.0 70.0 70.0 69.0 70.0 70.0 68.0 68.0 69.0 68.0 21:05:58 INFO - PROCESS | 25500 | -------- Summary: end -------- 21:05:58 INFO - PROCESS | 25500 | 21:05:59 INFO - TEST-INFO | 25500: exit 0 21:05:59 INFO - TEST-OK | kraken | took 64961ms 21:05:59 INFO - SUITE-END | took 1187s 21:06:00 INFO - Completed test suite (00:19:47) 21:06:00 INFO - javascript benchmark 21:06:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2514.308565144585, 2541.2757364151207, 2549.3371723351925, 2582.6384306197137, 2595.351162209449, 4572.748498832563, 4625.884352891179, 4652.418177819545, 4674.20538508454, 4702.459217190019, 4652.883677908054, 4665.533446655333, 4674.672772905889, 4676.812927482896, 4688.648351373652, 4244.660427165827, 4270.103278311558, 4277.037666525038, 4303.440552728141, 4309.396684464177, 4369.73781573105, 4373.037931655047, 4389.846355377563, 4417.050334178151, 4418.624416924549, 4331.610155086041, 4366.126774645068, 4390.67069969752, 4392.758398288093, 4413.4262545869, 4396.582324679151, 4433.756143412111, 4435.290353543418, 4438.201123797715, 4473.709208901411, 4216.746995180269, 4271.466066741657, 4271.743695378287, 4346.565343465628, 4349.717268377545, 4668.603168730662, 4673.369095172142, 4685.086408150412, 4686.742229177394, 4757.738324392157, 4991.50084991498, 5020.0963826511215, 5046.873828154289, 5053.0, 5080.5173508517, 4902.558769710708, 4951.306817045616, 4961.404631444214, 5065.518775716301, 5118.129917913926, 4694.389729335198, 4740.644451666139, 4759.6430267729365, 4795.352627395257, 4800.927986080212, 5215.322008138994, 5216.321878155892, 5218.08683480397, 5218.321618189611, 5253.3958594761325, 4977.352944117241, 4988.575971042429, 4989.5758860496535, 4993.400791904922, 5039.370078740158, 4892.828750993769, 4943.555080042814, 4947.6289278304275, 4987.102321582078, 5071.771770270347, 4894.461609222983, 4936.925946110811, 4952.2819191217795, 4953.356063711766, 4954.826581069645, 4926.655134140576, 4931.5561599455505, 4934.0, 4936.432310284292, 4937.136001199848, 4266.360045993064, 4313.41768861206, 4322.459692538433, 4333.696641235147, 4372.6939114261695, 3727.440883867387, 3751.512303400595, 3787.715921305913, 3817.2938006468894, 3853.556840963269, 4318.892027699333, 4328.350747387917, 4330.588594083557, 4366.366876802909, 4366.825326986885, 4899.436564795023, 4955.380577427822, 4960.156773348539, 5021.774020169101, 5030.673006254582, 4312.0, 4323.0057086869565, 4326.762028088486, 4349.891252718644, 4352.608265256142, 4592.563706447949, 4594.218982772936, 4597.414390994746, 4625.95374046262, 4642.907141857144, 4692.038132182963, 4694.0377222668585, 4698.201305777958, 4729.36153619257, 4741.620670346295, 4948.257761335828, 4994.575461085703, 5000.374953130859, 5034.395872495324, 5060.2156665716875, 4649.046945376257, 4666.673332866667, 4713.222318317439, 4722.7874745635845, 4739.526047395233, 4947.356843610308, 4957.975210123926, 4961.950380496149, 4963.354763880672, 5009.899802003866, 5001.799928002839, 5026.648134630541, 5045.394552653558, 5047.369078865142, 5080.898382032413, 4744.169770290255, 4750.0, 4800.4479484859685, 4841.370621819141, 4929.433115191799, 4849.660523763303, 4900.681455705368, 4930.82742104039, 4939.5554400104165, 4939.75301234944, 4824.710517368969, 4854.975725121351, 4860.684055536379, 4861.222204447272, 4926.137925862888, 4962.032403681247, 4965.205567109245, 4966.329545511454, 4973.502649735142, 5020.924686129784, 4627.514111018295, 4643.976780116078, 4693.507181746004, 4771.618270538418, 4845.878853028703], "value": 4613.550172729812, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.8832800947796, 546.5054126015955, 552.4227182594188, 554.8585110796746, 568.3662716071578, 27343.316417089558, 37313.626863731355, 38306.61693383065, 38422.039449013755, 42474.15051698964, 38504.807475962654, 39138.60861391385, 39220.21559568807, 39274.0, 39281.41077883827, 7537.773866784005, 7680.231976802331, 7689.423293253, 7690.65392057356, 7695.807604809868, 7542.396608271325, 7619.390448764113, 7624.885626715576, 7628.0464941882265, 7645.694172233132, 7652.846943061136, 7704.229577042307, 7712.344450721667, 7717.305442510173, 7721.652525636332, 7630.618469076552, 7660.578668173248, 7670.30967212948, 7678.616069196546, 7680.385569154454, 7543.811404714871, 7598.392128629696, 7603.353714934237, 7616.923830761677, 7619.123800762873, 36750.81624591887, 37084.25831483382, 37101.814490927645, 37197.814010930044, 37269.627303726884, 3012.9548056778945, 3037.104054303986, 3053.221428535709, 3241.6434192238835, 3249.983750081258, 25947.481050379076, 26485.0, 26956.865215673795, 27110.058417841778, 27291.590626140623, 3403.23427228874, 3439.0, 3515.6660117288816, 3639.399499082648, 3645.65366290202, 231706.0, 231986.0, 232122.0, 232144.0, 232719.0, 48281.27578086332, 48293.75853120782, 48389.758051209516, 48635.27047094297, 48659.51340486621, 50071.74964125229, 50108.498915011114, 50137.0, 50143.24785128226, 50149.0, 13141.802872956914, 13287.269200194081, 14579.41682332716, 14967.775483367759, 14994.775078373834, 10899.891001090045, 11221.382823944597, 11230.382328971822, 11232.382218977871, 11251.887481125248, 18362.265509379744, 18398.33224182486, 18498.56034551725, 18550.628987420176, 18673.0, 7152.713891444284, 7327.74352897646, 7389.194564799132, 7411.370033547101, 7427.689202220438, 784.9058113026473, 811.6307080278459, 842.9662813487391, 947.7444976505725, 959.9568019439142, 24481.265562033168, 26451.603225951625, 26846.060387886722, 26900.32749181247, 27019.86490067537, 906.9274458043341, 917.156216281023, 937.3672770879765, 956.063058202965, 967.2455484721928, 13263.602091937257, 14298.213598251989, 14462.132272063709, 14505.347259373353, 14566.63583410402, 415871.0, 424398.0, 627171.0, 628258.0, 628715.0, 46844.0, 47386.289205661946, 47398.5260147401, 47420.288695669595, 47427.762861185474, 1079.5250089960393, 1113.8440618313605, 1159.628918746027, 1193.8448001759716, 1198.376844041111, 24052.27843164708, 27344.316392090357, 29933.850330748206, 30995.535066974466, 31787.523187152674, 43361.34957975696, 44919.77540112279, 45010.19959201595, 51526.22710659268, 51586.0, 326983.0, 332442.0, 332476.0, 332508.7985922241, 334050.0, 30989.421904056584, 31750.841245793625, 34977.30045399027, 36438.63561364458, 36699.44950825686, 39046.609533904295, 39228.607713922494, 39361.0, 40021.19957600773, 40570.39144412895, 32342.514862276614, 32838.83580582177, 32951.0, 32967.91189894184, 33316.33367332688, 32020.51969220417, 32541.511877321387, 33206.418817901314, 33538.0, 33607.83196084004, 32761.836190818893, 33333.0, 33384.49923251104, 33494.497582536766, 33964.49053264154, 27581.724182758717, 30515.694843051286, 30631.54052689167, 30656.540151897294, 30883.11636450784, 23469.41326466852, 24052.0, 24141.275761727175, 24260.87869560641, 24342.0], "value": 17336.71253241573, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.7909856364537, 347.18065365736874, 353.93452211340906, 365.4937910993273, 387.2274811750558, 12497.43761530731, 13528.255945922983, 15554.688906221869, 15961.521154365359, 16734.16329183539, 13531.323433828318, 13712.314384280771, 13713.3828977696, 15310.311036003379, 16415.589610259718, 4843.225083986554, 5087.592992560586, 5090.363704536933, 5095.923561146567, 5097.006083813658, 4662.114198302312, 4991.376077990251, 5014.874628134289, 5019.247112933052, 5022.874428139289, 4981.0, 4984.675996060245, 4988.775505102279, 4989.077020751154, 5000.949990500085, 4794.137055330022, 4946.925796113025, 4975.800967961313, 4976.054549635558, 4989.850304490871, 4432.534583868712, 4432.955670443319, 4437.7781110944325, 4438.467383913951, 4439.400680908068, 19002.42992710221, 20218.696719549218, 20422.5915481691, 20423.0, 20451.0, 1809.6380723855282, 1963.8527110466773, 1984.4245168901002, 2016.2842191022123, 2404.4710163763943, 12108.57619983305, 12136.271823690518, 12701.682457938534, 13131.146475479063, 13693.0, 1656.1636373631238, 1687.9071651059187, 1695.4913525942168, 1745.6595963787067, 1747.318545767139, 65568.3443165567, 67544.32455675429, 67963.0, 68492.31507684909, 69809.30190698079, 9746.512674366253, 9908.0, 9986.30095893295, 10239.48802559869, 10494.737631559272, 13239.139455935334, 13260.668483287995, 13336.733265334638, 13373.53192638253, 13375.0, 7029.578225306498, 7200.207977122513, 7224.783256502314, 7431.777046688608, 7468.066491688539, 7038.718451261892, 7082.893756593655, 7166.283371662792, 7195.46034047438, 7235.167955685059, 4009.939850902239, 4078.0, 4186.769727664947, 4308.353746937984, 4421.977890110529, 1743.1981288607383, 1816.8546516278666, 1836.8714190006572, 1854.8887066776037, 1880.4774517285675, 667.8196886840526, 798.8202654402713, 815.7797394703515, 888.4580405952364, 903.439867282276, 16112.0, 16175.595610109842, 16416.261268242957, 16435.26041328143, 17170.742438863428, 805.1586092533316, 826.5371392020488, 853.5348235211825, 880.0759202836996, 893.7408151636083, 8656.39405241627, 9358.532073396304, 9444.95277523608, 9473.384230025027, 9573.808523829484, 352004.0, 360463.0, 364913.0, 365285.0, 366143.0, 69524.0, 70880.9119088087, 71397.14136047254, 72315.15272709135, 73369.0, 861.6036623153419, 879.8856148700756, 885.8272636835884, 889.2086043421231, 889.2574700125339, 13789.448422063406, 14905.925470372578, 14915.254237287874, 15178.468753593572, 15364.385424582892, 33877.83061084778, 35105.978804238744, 35580.04145632676, 35650.46524302189, 36519.63480365162, 45890.770546147054, 47869.0, 48022.279665804344, 48162.0, 50521.74739126281, 6428.517861160338, 7368.557886526825, 7473.476856619985, 7571.886421703789, 7989.520628762293, 8551.273141783018, 11812.881871181522, 11926.642200733992, 12319.815202771786, 12331.75336493283, 10217.386956782617, 10300.587976481156, 10474.162067034771, 10642.308249963728, 11048.558057677603, 9646.372985755903, 9676.516174191122, 9752.268579856398, 9764.0, 10067.949660251652, 10188.960716061662, 10273.897261027294, 10325.122364599094, 10403.791924161626, 10483.37099774016, 6517.3808488193545, 6614.140161778938, 6642.302558231316, 7067.2579379164445, 7277.199508054004, 8077.798055048671, 9972.252081093802, 10187.083162515113, 10474.121788630247, 10689.9465502672], "value": 7944.191011855007, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1300.674831292177, 1337.739140867531, 1378.827646544182, 1577.7317855964484, 1604.5988502874275, 6554.1479607651, 7014.824629384268, 7017.508774385782, 7020.8946865796925, 7021.1925628552735, 5761.279840019997, 5956.88086238275, 6573.441257493118, 6781.2201596816385, 6854.931450685492, 2036.4908772806798, 2067.3074520035807, 2076.345951025422, 2077.1898959405767, 2077.55332603491, 2023.3120738948755, 2048.4059622709397, 2055.0341339570455, 2071.140476702167, 2075.4603803011173, 1720.2087039961632, 1779.9110044497788, 1944.7860735319105, 2003.9298624548144, 2043.5810658814908, 1989.254029738848, 1991.7211590377215, 1992.3425269661122, 2000.5098750806073, 2002.2391491233238, 1976.505873531617, 1978.8120128587761, 2014.74815648044, 2031.7968203179712, 2033.4001469566513, 6552.213734351861, 6606.834829129262, 6723.831904202385, 6788.1175447191545, 6788.694508747119, 4138.52406973199, 4267.0825772459075, 4270.701050926436, 4273.337632666941, 4274.038341373197, 2611.9477610447684, 2778.5554311310298, 2792.3437992071845, 2822.3508593023516, 2895.7104289570875, 821.342925659476, 855.3029281135854, 862.8878245828065, 878.8901387326584, 881.5063564403954, 8774.078721734253, 8781.64873405063, 8788.20906118446, 8811.206991370744, 8836.646534138627, 3624.7462677612316, 3736.0473079365133, 3811.5045044144085, 3815.0924537731134, 3867.7099217558793, 6518.445932095825, 6796.558223715443, 7727.227277272228, 7735.0, 7736.497127686683, 4055.209234199303, 4168.812403441852, 4174.977130603022, 4177.874663760092, 4183.3515805050265, 3909.5308562972627, 3929.7249192556246, 3950.6444420001762, 3957.1294315250598, 3961.3265744822875, 2761.9585706214425, 2813.1560531840364, 2879.07869481768, 2965.481040817848, 2976.702329767006, 842.8819965204876, 843.7300063979468, 847.0682249525472, 855.6919508976763, 855.8288342331558, 643.5623775832386, 771.5833449937084, 783.0446854837089, 793.8571057209758, 831.4553967151526, 4514.232580461329, 4555.06621142665, 4574.428196475441, 4578.908421831611, 4700.976495117503, 388.14801510683776, 389.41004378366796, 394.936810110381, 396.96824254059607, 409.21226638720344, 3110.7977981431136, 3125.1093438369953, 3194.4409728297455, 3290.3254832759226, 3361.2269178089177, 7743.7676869694, 8277.62750676221, 8334.874976875351, 8359.665613375397, 8386.87419688705, 8316.293115085286, 8319.209675080858, 8321.875171872305, 8322.70870519541, 8328.83342333162, 6122.724477398528, 6475.061116138134, 6530.738770449128, 6580.835479112965, 6581.934180658132, 4458.264386376211, 4495.865124046284, 4513.909721805479, 4555.020670555847, 4762.214234651382, 7665.808354791175, 7742.225777422213, 7745.612719363897, 7749.806254843674, 7765.844683106419, 7563.73526926577, 7628.351590114902, 7629.16079231273, 7643.0, 7779.844403112019, 5650.971745141248, 5764.394738552559, 5777.364489906023, 5782.884342313214, 5788.0739081746715, 6293.874122517615, 6318.4313411793155, 6396.456301214449, 6498.675066246763, 6536.182977127859, 5747.1379293106365, 5844.795432159854, 5868.413158684098, 5996.2504686914135, 6053.848653783691, 5779.711014449176, 5887.116932460165, 5903.793367232126, 5915.053591425351, 5967.701614919323, 5392.649477783932, 5458.918116228339, 5506.311711036121, 5515.062439385234, 5529.529989950899, 3994.281029414617, 4035.6771458283856, 4083.183363327406, 4120.072983578671, 4205.91588168241, 3852.9807350963065, 4004.3993400990084, 4016.49793775778, 4052.3313653246882, 4146.460960075171], "value": 3575.627188795537, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [275.3748989793168, 284.7949476377009, 291.80011691990984, 298.93274013347, 300.84807172377947, 4574.473935497419, 4726.456457507387, 4793.257045158001, 4823.20417131173, 4878.8780280493, 4644.140833945714, 4750.952490475102, 4767.666263361557, 4781.450133234679, 4783.234682450809, 3704.1850792825535, 3729.552453705559, 3734.4128745283283, 3770.4344348347695, 3772.8868133956025, 3577.874774382897, 3672.559292884844, 3677.797721125337, 3681.171736359311, 3757.887263382103, 3670.9816450917706, 3748.868789592365, 3776.3202623527754, 3778.414345776409, 3787.772733635991, 3740.3080430120244, 3741.906452338686, 3751.1559899022773, 3751.2872554214614, 3752.3058234226755, 3307.3881331953667, 3307.4377355849565, 3318.3197444523817, 3321.0701003718755, 3332.950005749916, 4549.340345649895, 4604.447466304032, 4641.466231383367, 4663.347131401607, 4671.205894997858, 4280.957190428087, 4288.284686125544, 4293.046663767978, 4302.182585308781, 4317.11499142675, 4948.8472514456325, 4958.429780575244, 4959.504049595012, 4978.676386034932, 5012.223105418666, 3348.648391918862, 3511.2099777549847, 3545.1461573433376, 3566.5006899034156, 3622.2031153146268, 5188.8183913563225, 5197.090509160882, 5208.244804503326, 5230.8169214077325, 5241.344831896013, 3612.1692010837655, 3615.6745892869767, 3623.166671665532, 3630.8910732678064, 3635.8909232723063, 3462.9134271642906, 3680.742348035612, 3681.5950245472977, 3681.9263614727556, 3689.9262014759556, 3935.4883865097927, 4056.1684854604737, 4060.4924384451942, 4162.396452514429, 4167.8332866685, 4981.825636102792, 4995.975824955875, 5016.3446062799185, 5045.823396181116, 5056.974715126401, 1219.1892391559513, 1221.4930803716536, 1222.5598784437595, 1224.8731167326082, 1229.84012078431, 789.9249571290718, 827.8344331133798, 832.5171400587644, 841.3017195727532, 844.1980118887082, 4314.633256173198, 4317.287647538184, 4347.891272732722, 4358.891027724332, 4367.497737760198, 4988.351514303117, 5015.172496538104, 5024.221245706848, 5042.546170844642, 5061.240813877947, 4268.186020941088, 4278.893027674333, 4281.529031806561, 4355.303151495746, 4370.628496577827, 2445.7065152181854, 2576.9098081567054, 2622.396848724804, 2624.8687565621644, 2653.6152257922495, 4589.33454649074, 4608.170529304757, 4639.979204574988, 4663.603593694574, 4689.365741550326, 5070.873228169326, 5093.2105523643895, 5097.1844504879045, 5107.9823469729245, 5130.615203859726, 4582.24392975162, 4826.3243145958895, 4835.879103022523, 4843.39457567804, 4893.681910675795, 5203.531682148625, 5215.765290561858, 5220.660657057279, 5244.76398562058, 5258.447862974485, 4942.418426103613, 5105.463926287686, 5172.172452407597, 5172.870678233075, 5174.97412512935, 4796.472388037383, 4840.564349208588, 4868.2210846264425, 4881.682690625098, 4898.118338698926, 3576.463530470346, 3599.6940260078186, 3609.9819500902327, 3614.584322802911, 3620.366435873764, 4998.525140111684, 5077.136886729339, 5249.921251181312, 5261.605379596469, 5275.894482110413, 4871.683340582851, 4962.851114466572, 5018.799248030038, 5022.221555658879, 5031.6729412588065, 5008.873003574312, 5013.0, 5013.598912086952, 5020.397552293748, 5026.195808670595, 4797.832075877328, 4895.804167833389, 4948.8762780930765, 4960.77676504551, 4989.25161225819, 5025.321581586439, 5036.647434679538, 5038.445770965264, 5044.646874718735, 5045.394552653705, 4915.8033678652455, 4934.333864928332, 4934.407871055496, 4971.453140154653, 4993.750312484434], "value": 3741.8339222219574, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [627.2567008095407, 659.6916463933372, 660.8050625065608, 727.3308556128361, 729.5695539631616, 12066.457009434575, 12740.362981850916, 12744.80882786759, 12769.233845969236, 12770.0, 11439.370834604093, 11442.084633229342, 11451.599194028211, 11555.653330400102, 11623.535058597647, 612.3539665652735, 626.8056902360283, 728.5992704012798, 739.3198257603004, 753.4763339479064, 745.6346390268784, 760.6767123972318, 761.0296871488869, 761.4898018327706, 761.7905076104088, 807.1242701668697, 809.2676128104075, 809.5871105736088, 809.7004108479841, 809.76516810125, 629.109809619388, 644.255884453457, 772.1853444615928, 809.4333966223637, 810.0, 582.0512564519848, 583.3262581718122, 583.7781642975684, 583.9708014599253, 584.4914924016091, 11319.547218111265, 11341.943290283578, 11375.089992800557, 11379.14656400765, 11423.371714555697, 11527.0, 11566.826497602542, 11691.532338706442, 11754.29474231549, 11916.404179790976, 9496.952515237448, 9599.232061435068, 9781.853272200922, 9837.0, 10803.459827008619, 3993.4009898515164, 4012.0772222388723, 4015.0966032642714, 4030.0, 4042.2521833460905, 46851.0, 47531.28703069422, 47607.52392476066, 48714.512854871355, 49123.50876491225, 9583.233341332676, 9622.182114520205, 9731.708048758548, 9805.509724513888, 9828.557714902847, 16358.345666173458, 16394.1802909854, 16397.0, 16464.341426342813, 16550.089745063895, 6227.719752611143, 6298.685065746694, 6299.181106456132, 6425.293217746044, 6551.541392102602, 3421.674940880612, 3459.9481007784902, 3573.3746594345885, 3578.6958108561066, 3679.411294192916, 2421.830471866988, 2497.4006238502993, 2507.2227609440765, 2659.946801063968, 2788.177487641151, 499.28851386773704, 500.2696063746898, 511.12342332898515, 511.1719015195333, 522.0186050225552, 495.63075508745493, 600.7326739600923, 606.5269090109722, 610.920580324555, 624.8346833156131, 7501.887471687929, 7513.2862378074, 7565.167831538526, 7900.367970562456, 7982.481138725964, 460.2176300289521, 519.8752299448105, 521.8773588206768, 533.9733013349316, 565.5249590344131, 3685.0418891087975, 3715.64701353371, 3723.6727045596504, 3746.7377283589885, 3918.0988372674447, 42835.78582107132, 43196.78401607972, 43234.351484727755, 62788.744225116156, 74719.0, 62432.68783656053, 62534.37465625376, 62771.37228627747, 62863.68568157221, 62951.0, 44499.33251001238, 46862.0, 50440.24339634835, 50660.74669626628, 50750.0, 8134.722277762236, 8445.0, 8548.700795472128, 8615.48307101551, 8654.264387527131, 25461.0, 32301.838490807397, 34073.31853362968, 34959.65040349564, 35689.82155089208, 36380.454293185096, 47426.76286618545, 47792.283115752594, 47919.0, 48189.0, 10276.280660353703, 10294.485275736333, 10388.636397726043, 10421.06210441064, 10522.736931576772, 11628.592999244986, 11986.0, 12000.699982500508, 12072.698182545506, 12799.168054076456, 10987.890121098686, 11150.519631057048, 11305.7738845221, 11366.147538934447, 11869.40652967331, 10902.945485272523, 11015.063719583604, 11258.211925165488, 11921.46353414081, 11947.223430476992, 10592.682219533426, 10885.238033337908, 10887.564497420015, 10973.451327433757, 11585.246958947642, 8681.652733890574, 8903.19871211594, 9168.0, 9355.158035776813, 9403.247740180632, 8981.326400519856, 9242.537873106452, 9364.672236471692, 9406.717798466058, 9421.340506164503], "value": 5907.7415211367625, "unit": "score"}], "name": "dromaeo_css", "value": 6074.2728737454345, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 115.0, 117.0, 117.0, 116.0, 117.0, 116.0, 115.0, 116.0, 116.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 130.0, 132.0, 176.0, 136.0, 131.0, 131.0, 132.0, 167.0, 130.0], "value": 142.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 162.0, 161.0, 164.0, 160.0, 161.0, 160.0, 164.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 77.0, 119.0, 79.0, 77.0, 76.0, 77.0, 102.0, 76.0], "value": 83.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 114.0, 83.0, 83.0, 84.0, 105.0, 83.0, 84.0, 115.0], "value": 91.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 149.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 67.0, 66.0, 66.0, 65.0, 66.0, 66.0, 72.0], "value": 66.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 67.0, 68.0, 67.0, 67.0, 67.0, 68.0, 67.0], "value": 66.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 90.0, 92.0, 86.0, 95.0, 86.0, 86.0, 94.0, 85.0, 85.0], "value": 88.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 148.0, 141.0, 150.0, 152.0, 146.0, 157.0, 152.0, 181.0, 146.0], "value": 152.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 180.0, 180.0, 181.0, 177.0, 180.0, 179.0, 179.0, 180.0, 177.0], "value": 179.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 70.0, 69.0, 70.0, 70.0, 68.0, 68.0, 69.0, 68.0], "value": 69.2, "unit": "score"}], "name": "kraken", "value": 1578.1, "alertThreshold": 2.0}]} 21:06:00 INFO - Return code: 0 21:06:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:06:00 INFO - # TBPL SUCCESS # 21:06:00 INFO - Running post-action listener: _resource_record_post_action 21:06:00 INFO - [mozharness: 2016-11-23 05:06:00.209431Z] Finished run-tests step (success) 21:06:00 INFO - Running post-run listener: _resource_record_post_run 21:06:00 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 408272896; Read time: 12; Write time: 228048 21:06:00 INFO - TinderboxPrint: CPU usage
13.0% 21:06:00 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 21:06:00 INFO - TinderboxPrint: I/O write bytes / time
408,272,896 / 228,048 21:06:00 INFO - TinderboxPrint: CPU idle
8,351.8 (86.9%) 21:06:00 INFO - TinderboxPrint: CPU user
1,206.9 (12.6%) 21:06:00 INFO - TinderboxPrint: Swap in / out
0 / 0 21:06:00 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 115777536; Read time: 0; Write time: 62848 21:06:00 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 291471360; Read time: 0; Write time: 165180 21:06:00 INFO - Running post-run listener: _upload_blobber_files 21:06:00 INFO - Blob upload gear active. 21:06:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:06:00 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 21:06:00 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:06:00 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:06:01 INFO - (blobuploader) - INFO - Open directory for files ... 21:06:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:06:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:06:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:06:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:06:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:06:04 INFO - (blobuploader) - INFO - Done attempting. 21:06:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:06:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:06:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:06:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:06:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:06:05 INFO - (blobuploader) - INFO - Done attempting. 21:06:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:06:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:06:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:06:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:06:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:06:06 INFO - (blobuploader) - INFO - Done attempting. 21:06:06 INFO - (blobuploader) - INFO - Iteration through files over. 21:06:06 INFO - Return code: 0 21:06:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:06:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:06:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e1d6eb060c4b8956b8e6f69e7c1e04eee0220dcac9df9d837595f75f20713c7008f6a4a2eb4e39c1a60fbde0e939ff27322b4e827d717f5b07ea2cd276679124", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6c83b72483a129d8908d435009d0cfcb69a86f3c7bfe362f542a2f9e0def3d6b4bd8cebd44cea2965f4d8922200dd0e84e867a9e628fc3ea178459e82c375e82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f490cd091e64a7eac1a74eb6382ee9671a320882e727b322804a75dfdd6e13b6b3d6e2b954542410773cdfedf8e26b28fea9cfd5a21ef0454f217f167652108a"} 21:06:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:06:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:06:06 INFO - Contents: 21:06:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e1d6eb060c4b8956b8e6f69e7c1e04eee0220dcac9df9d837595f75f20713c7008f6a4a2eb4e39c1a60fbde0e939ff27322b4e827d717f5b07ea2cd276679124", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6c83b72483a129d8908d435009d0cfcb69a86f3c7bfe362f542a2f9e0def3d6b4bd8cebd44cea2965f4d8922200dd0e84e867a9e628fc3ea178459e82c375e82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f490cd091e64a7eac1a74eb6382ee9671a320882e727b322804a75dfdd6e13b6b3d6e2b954542410773cdfedf8e26b28fea9cfd5a21ef0454f217f167652108a"} 21:06:06 INFO - Running post-run listener: copy_logs_to_upload_dir 21:06:06 INFO - Copying logs to upload dir... 21:06:06 INFO - mkdir: /builds/slave/test/build/upload/logs 21:06:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.239624 ========= master_lag: 0.59 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-11-22 21:06:06.254316) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-22 21:06:06.257544) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1479866219.899489-291600571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e1d6eb060c4b8956b8e6f69e7c1e04eee0220dcac9df9d837595f75f20713c7008f6a4a2eb4e39c1a60fbde0e939ff27322b4e827d717f5b07ea2cd276679124", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6c83b72483a129d8908d435009d0cfcb69a86f3c7bfe362f542a2f9e0def3d6b4bd8cebd44cea2965f4d8922200dd0e84e867a9e628fc3ea178459e82c375e82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f490cd091e64a7eac1a74eb6382ee9671a320882e727b322804a75dfdd6e13b6b3d6e2b954542410773cdfedf8e26b28fea9cfd5a21ef0454f217f167652108a"} build_url:https://queue.taskcluster.net/v1/task/I_OESP6IS1e7eV12pm_KNQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011438 build_url: 'https://queue.taskcluster.net/v1/task/I_OESP6IS1e7eV12pm_KNQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e1d6eb060c4b8956b8e6f69e7c1e04eee0220dcac9df9d837595f75f20713c7008f6a4a2eb4e39c1a60fbde0e939ff27322b4e827d717f5b07ea2cd276679124", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6c83b72483a129d8908d435009d0cfcb69a86f3c7bfe362f542a2f9e0def3d6b4bd8cebd44cea2965f4d8922200dd0e84e867a9e628fc3ea178459e82c375e82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f490cd091e64a7eac1a74eb6382ee9671a320882e727b322804a75dfdd6e13b6b3d6e2b954542410773cdfedf8e26b28fea9cfd5a21ef0454f217f167652108a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-22 21:06:06.291044) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 21:06:06.291471) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1479866219.899489-291600571 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 21:06:06.344282) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-22 21:06:06.344700) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-22 21:06:06.345587) ========= ========= Total master_lag: 0.73 =========