builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-032 starttime: 1475372789.33 results: success (0) buildid: 20161001153006 builduid: 615e305eff2f4d7dadca825b8ee1055a revision: 0eed0d06ea6d4053f1f9f85ba6bc0e0db6b4eac6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-01 18:46:29.329036) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-01 18:46:29.329592) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-01 18:46:29.329964) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-01 18:46:29.342012) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 18:46:29.342310) ========= 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=745a4373a2a16df560f216e000000264-1475372789.598508-952381448 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-01 18:46:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.4M=0s 2016-10-01 18:46:30 (43.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120073 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 18:46:29.477618) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 18:46:29.478393) ========= 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=745a4373a2a16df560f216e000000264-1475372789.598508-952381448 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017570 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 18:46:29.531834) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-01 18:46:29.532653) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 0eed0d06ea6d4053f1f9f85ba6bc0e0db6b4eac6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 0eed0d06ea6d4053f1f9f85ba6bc0e0db6b4eac6 --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=745a4373a2a16df560f216e000000264-1475372789.598508-952381448 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-01 18:46:30,557 truncating revision to first 12 chars 2016-10-01 18:46:30,558 Setting DEBUG logging. 2016-10-01 18:46:30,558 attempt 1/10 2016-10-01 18:46:30,558 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/0eed0d06ea6d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-01 18:46:32,821 unpacking tar archive at: mozilla-inbound-0eed0d06ea6d/testing/mozharness/ program finished with exit code 0 elapsedTime=2.642890 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-01 18:46:32.194959) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-01 18:46:32.195378) ========= script_repo_revision: 0eed0d06ea6d4053f1f9f85ba6bc0e0db6b4eac6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-01 18:46:32.196216) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-01 18:46:32.196865) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-01 18:46:32.208875) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-10-01 18:46:32.209216) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=745a4373a2a16df560f216e000000264-1475372789.598508-952381448 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:46:33 INFO - MultiFileLogger online at 20161001 18:46:33 in /builds/slave/test 18:46:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 18:46:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:46:33 INFO - {'append_to_log': False, 18:46:33 INFO - 'base_work_dir': '/builds/slave/test', 18:46:33 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 18:46:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:46:33 INFO - 'branch': 'Mozilla-Inbound', 18:46:33 INFO - 'buildbot_json_path': 'buildprops.json', 18:46:33 INFO - 'config_files': ('talos/linux_config.py',), 18:46:33 INFO - 'default_actions': ('clobber', 18:46:33 INFO - 'read-buildbot-config', 18:46:33 INFO - 'download-and-extract', 18:46:33 INFO - 'populate-webroot', 18:46:33 INFO - 'create-virtualenv', 18:46:33 INFO - 'install', 18:46:33 INFO - 'run-tests'), 18:46:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:46:33 INFO - 'download_minidump_stackwalk': True, 18:46:33 INFO - 'download_symbols': 'ondemand', 18:46:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:46:33 INFO - 'tooltool.py': '/tools/tooltool.py', 18:46:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:46:33 INFO - '/tools/misc-python/virtualenv.py')}, 18:46:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:46:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:46:33 INFO - 'installer_path': 'installer.exe', 18:46:33 INFO - 'log_level': 'info', 18:46:33 INFO - 'log_name': 'talos', 18:46:33 INFO - 'log_to_console': True, 18:46:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:46:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:46:33 INFO - 'opt_config_files': (), 18:46:33 INFO - 'pip_index': False, 18:46:33 INFO - 'sps_profile': False, 18:46:33 INFO - 'sps_profile_interval': 0, 18:46:33 INFO - 'suite': 'dromaeojs', 18:46:33 INFO - 'system_bits': '32', 18:46:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:46:33 INFO - 'title': 'talos-linux64-ix-032', 18:46:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:46:33 INFO - 'use_talos_json': True, 18:46:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:46:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:46:33 INFO - 'work_dir': 'build'} 18:46:33 INFO - [mozharness: 2016-10-02 01:46:33.336407Z] Running clobber step. 18:46:33 INFO - Running pre-action listener: _resource_record_pre_action 18:46:33 INFO - Running main action method: clobber 18:46:33 INFO - rmtree: /builds/slave/test/build 18:46:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:46:33 INFO - Running post-action listener: _resource_record_post_action 18:46:33 INFO - [mozharness: 2016-10-02 01:46:33.800934Z] Finished clobber step (success) 18:46:33 INFO - [mozharness: 2016-10-02 01:46:33.801035Z] Running read-buildbot-config step. 18:46:33 INFO - Running pre-action listener: _resource_record_pre_action 18:46:33 INFO - Running main action method: read_buildbot_config 18:46:33 INFO - Using buildbot properties: 18:46:33 INFO - { 18:46:33 INFO - "project": "", 18:46:33 INFO - "product": "firefox", 18:46:33 INFO - "script_repo_revision": "production", 18:46:33 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 18:46:33 INFO - "repository": "", 18:46:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 18:46:33 INFO - "buildid": "20161001153006", 18:46:33 INFO - "pgo_build": "True", 18:46:33 INFO - "basedir": "/builds/slave/test", 18:46:33 INFO - "buildnumber": 2517, 18:46:33 INFO - "slavename": "talos-linux64-ix-032", 18:46:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:46:33 INFO - "platform": "ubuntu64_hw", 18:46:33 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 18:46:33 INFO - "branch": "mozilla-inbound", 18:46:33 INFO - "repo_path": "integration/mozilla-inbound", 18:46:33 INFO - "revision": "0eed0d06ea6d4053f1f9f85ba6bc0e0db6b4eac6", 18:46:33 INFO - "stage_platform": "linux64-pgo", 18:46:33 INFO - "builduid": "615e305eff2f4d7dadca825b8ee1055a", 18:46:33 INFO - "slavebuilddir": "test" 18:46:33 INFO - } 18:46:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/fXj3d8e1Rc2-6D01XTVuqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 18:46:33 INFO - Running post-action listener: _resource_record_post_action 18:46:33 INFO - [mozharness: 2016-10-02 01:46:33.803471Z] Finished read-buildbot-config step (success) 18:46:33 INFO - [mozharness: 2016-10-02 01:46:33.803559Z] Running download-and-extract step. 18:46:33 INFO - Running pre-action listener: _resource_record_pre_action 18:46:33 INFO - Running main action method: download_and_extract 18:46:33 INFO - mkdir: /builds/slave/test/build/tests 18:46:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:46:33 INFO - trying https://queue.taskcluster.net/v1/task/fXj3d8e1Rc2-6D01XTVuqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:46:33 INFO - Downloading https://queue.taskcluster.net/v1/task/fXj3d8e1Rc2-6D01XTVuqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:46:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fXj3d8e1Rc2-6D01XTVuqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:46:34 INFO - Downloaded 1361 bytes. 18:46:34 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:46:34 INFO - Using the following test package requirements: 18:46:34 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:46:34 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:46:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:46:34 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:46:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:46:34 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:46:34 INFO - u'jsshell-linux-x86_64.zip'], 18:46:34 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:46:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:46:34 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:46:34 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:46:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:46:34 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:46:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:46:34 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:46:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:46:34 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:46:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:46:34 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:46:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fXj3d8e1Rc2-6D01XTVuqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:46:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fXj3d8e1Rc2-6D01XTVuqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:46:34 INFO - Fetch https://queue.taskcluster.net/v1/task/fXj3d8e1Rc2-6D01XTVuqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:46:34 INFO - Http code: 200 18:46:34 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 18:46:34 INFO - x-amz-cf-id: jrKc0r9V1PyacG1T4sJfFKElI7ifuFSA1dJhtTyrIgj4XUzYIIV4_A== 18:46:34 INFO - x-amz-version-id: CcXi3YEsTlcVeOHCwfXee_cV87tZacBc 18:46:35 INFO - Expected file size: 21991657 18:46:35 INFO - Obtained file size: 21991657 18:46:39 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:46:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fXj3d8e1Rc2-6D01XTVuqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:46:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fXj3d8e1Rc2-6D01XTVuqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:46:39 INFO - Fetch https://queue.taskcluster.net/v1/task/fXj3d8e1Rc2-6D01XTVuqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:46:39 INFO - Http code: 200 18:46:39 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 18:46:39 INFO - x-amz-cf-id: k8GRRH-bXTW1nrzdtttEmVZEKMej8zT36216pjRhAY-3luPnpYLNAw== 18:46:39 INFO - x-amz-version-id: CcXi3YEsTlcVeOHCwfXee_cV87tZacBc 18:46:40 INFO - Expected file size: 21991657 18:46:40 INFO - Obtained file size: 21991657 18:46:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fXj3d8e1Rc2-6D01XTVuqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 18:46:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fXj3d8e1Rc2-6D01XTVuqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:46:44 INFO - Fetch https://queue.taskcluster.net/v1/task/fXj3d8e1Rc2-6D01XTVuqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 18:46:45 INFO - Http code: 200 18:46:45 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 18:46:45 INFO - x-amz-cf-id: uhBSYYfLLu0S2BcvHPr6Nb-xwJ5mGostopZsR_HvhWzzIC0BX8uB8g== 18:46:45 INFO - x-amz-version-id: tNxDz.Hn7VRNrR.EEWzLb7xGl8XuOpRc 18:46:45 INFO - Expected file size: 14408522 18:46:45 INFO - Obtained file size: 14408522 18:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:46:45 INFO - trying https://queue.taskcluster.net/v1/task/fXj3d8e1Rc2-6D01XTVuqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:46:45 INFO - Downloading https://queue.taskcluster.net/v1/task/fXj3d8e1Rc2-6D01XTVuqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:46:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fXj3d8e1Rc2-6D01XTVuqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:46:46 INFO - Downloaded 59687445 bytes. 18:46:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fXj3d8e1Rc2-6D01XTVuqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:46:46 INFO - mkdir: /builds/slave/test/properties 18:46:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:46:46 INFO - Writing to file /builds/slave/test/properties/build_url 18:46:46 INFO - Contents: 18:46:46 INFO - build_url:https://queue.taskcluster.net/v1/task/fXj3d8e1Rc2-6D01XTVuqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:46:47 INFO - Running post-action listener: _resource_record_post_action 18:46:47 INFO - Running post-action listener: set_extra_try_arguments 18:46:47 INFO - [mozharness: 2016-10-02 01:46:47.535810Z] Finished download-and-extract step (success) 18:46:47 INFO - [mozharness: 2016-10-02 01:46:47.536036Z] Running populate-webroot step. 18:46:47 INFO - Running pre-action listener: _resource_record_pre_action 18:46:47 INFO - Running main action method: populate_webroot 18:46:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:46:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:46:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:46:47 INFO - '--tppagecycles', 18:46:47 INFO - '7'], 18:46:47 INFO - 'tests': ['tsvgm']}}, 18:46:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:46:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:46:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:46:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:46:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:46:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:46:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:47 INFO - 'talos_options': ['--disable-e10s'], 18:46:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:46:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:46:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:47 INFO - 'talos_options': ['--disable-e10s'], 18:46:47 INFO - 'tests': ['damp', 'tps']}, 18:46:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:47 INFO - 'tests': ['damp', 'tps']}, 18:46:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:46:47 INFO - 'tests': ['dromaeo_dom']}, 18:46:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:46:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:46:47 INFO - 'tests': ['basic_compositor_video']}, 18:46:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:46:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:46:47 INFO - 'tests': ['a11yr', 18:46:47 INFO - 'ts_paint', 18:46:47 INFO - 'tpaint', 18:46:47 INFO - 'sessionrestore', 18:46:47 INFO - 'sessionrestore_no_auto_restore', 18:46:47 INFO - 'tabpaint']}, 18:46:47 INFO - 'other-e10s': {'tests': ['a11yr', 18:46:47 INFO - 'ts_paint', 18:46:47 INFO - 'tpaint', 18:46:47 INFO - 'sessionrestore', 18:46:47 INFO - 'sessionrestore_no_auto_restore', 18:46:47 INFO - 'tabpaint']}, 18:46:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:46:47 INFO - 'ts_paint', 18:46:47 INFO - 'tpaint', 18:46:47 INFO - 'sessionrestore', 18:46:47 INFO - 'sessionrestore_no_auto_restore', 18:46:47 INFO - 'tabpaint']}, 18:46:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:46:47 INFO - 'ts_paint', 18:46:47 INFO - 'tpaint', 18:46:47 INFO - 'sessionrestore', 18:46:47 INFO - 'sessionrestore_no_auto_restore', 18:46:47 INFO - 'tabpaint']}, 18:46:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:46:47 INFO - 'tests': ['a11yr', 18:46:47 INFO - 'ts_paint', 18:46:47 INFO - 'tpaint', 18:46:47 INFO - 'sessionrestore', 18:46:47 INFO - 'sessionrestore_no_auto_restore', 18:46:47 INFO - 'tabpaint']}, 18:46:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:46:47 INFO - 'tests': ['a11yr', 18:46:47 INFO - 'ts_paint', 18:46:47 INFO - 'tpaint', 18:46:47 INFO - 'sessionrestore', 18:46:47 INFO - 'sessionrestore_no_auto_restore', 18:46:47 INFO - 'tabpaint']}, 18:46:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:46:47 INFO - 'tests': ['tsvgx', 18:46:47 INFO - 'tsvgr_opacity', 18:46:47 INFO - 'tart', 18:46:47 INFO - 'tscrollx', 18:46:47 INFO - 'cart']}, 18:46:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:46:47 INFO - 'tsvgr_opacity', 18:46:47 INFO - 'tart', 18:46:47 INFO - 'tscrollx', 18:46:47 INFO - 'cart']}, 18:46:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:47 INFO - 'talos_options': ['--disable-e10s'], 18:46:47 INFO - 'tests': ['tp5o']}, 18:46:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:47 INFO - 'tests': ['tp5o']}, 18:46:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:47 INFO - 'talos_options': ['--disable-e10s', 18:46:47 INFO - '--xperf_path', 18:46:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:46:47 INFO - 'tests': ['tp5n']}, 18:46:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:47 INFO - 'talos_options': ['--xperf_path', 18:46:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:46:47 INFO - 'tests': ['tp5n']}}, 18:46:47 INFO - 'talos.zip': {'path': '', 18:46:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:46:47 INFO - Running post-action listener: _resource_record_post_action 18:46:47 INFO - [mozharness: 2016-10-02 01:46:47.551417Z] Finished populate-webroot step (success) 18:46:47 INFO - [mozharness: 2016-10-02 01:46:47.551506Z] Running create-virtualenv step. 18:46:47 INFO - Running pre-action listener: _resource_record_pre_action 18:46:47 INFO - Running main action method: create_virtualenv 18:46:47 INFO - Creating virtualenv /builds/slave/test/build/venv 18:46:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:46:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:46:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:46:47 INFO - Using real prefix '/usr' 18:46:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:46:48 INFO - Installing distribute.............................................................................................................................................................................................done. 18:46:50 INFO - Installing pip.................done. 18:46:50 INFO - Return code: 0 18:46:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:46:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:46:50 INFO - Reading from file tmpfile_stdout 18:46:50 INFO - Output received: 18:46:50 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:46:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:46:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:46:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:50 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 0x7fba1532ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a2f60>, '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 0x22a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a41d0>, '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': '745a4373a2a16df560f216e000000264-1475372789.598508-952381448', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:46:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:46:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:46:50 INFO - Using env: {'DISPLAY': ':0', 18:46:50 INFO - 'HOME': '/home/cltbld', 18:46:50 INFO - 'LANG': 'en_US.UTF-8', 18:46:50 INFO - 'LANGUAGE': 'en_US:en', 18:46:50 INFO - 'LOGNAME': 'cltbld', 18:46:50 INFO - 'MAIL': '/var/mail/cltbld', 18:46:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:50 INFO - 'MOZ_NO_REMOTE': '1', 18:46:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:50 INFO - 'NO_EM_RESTART': '1', 18:46:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:50 INFO - 'PWD': '/builds/slave/test', 18:46:50 INFO - 'SHELL': '/bin/bash', 18:46:50 INFO - 'SHLVL': '1', 18:46:50 INFO - 'TERM': 'linux', 18:46:50 INFO - 'TMOUT': '86400', 18:46:50 INFO - 'USER': 'cltbld', 18:46:50 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1475372789.598508-952381448', 18:46:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:50 INFO - '_': '/tools/buildbot/bin/python'} 18:46:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:46:50 INFO - Cleaning up... 18:46:50 INFO - Return code: 0 18:46:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:46:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:46:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:50 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 0x7fba1532ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a2f60>, '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 0x22a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a41d0>, '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': '745a4373a2a16df560f216e000000264-1475372789.598508-952381448', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:46:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:46:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:46:50 INFO - Using env: {'DISPLAY': ':0', 18:46:50 INFO - 'HOME': '/home/cltbld', 18:46:50 INFO - 'LANG': 'en_US.UTF-8', 18:46:50 INFO - 'LANGUAGE': 'en_US:en', 18:46:50 INFO - 'LOGNAME': 'cltbld', 18:46:50 INFO - 'MAIL': '/var/mail/cltbld', 18:46:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:50 INFO - 'MOZ_NO_REMOTE': '1', 18:46:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:50 INFO - 'NO_EM_RESTART': '1', 18:46:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:50 INFO - 'PWD': '/builds/slave/test', 18:46:50 INFO - 'SHELL': '/bin/bash', 18:46:50 INFO - 'SHLVL': '1', 18:46:50 INFO - 'TERM': 'linux', 18:46:50 INFO - 'TMOUT': '86400', 18:46:50 INFO - 'USER': 'cltbld', 18:46:50 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1475372789.598508-952381448', 18:46:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:50 INFO - '_': '/tools/buildbot/bin/python'} 18:46:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:50 INFO - Downloading/unpacking psutil>=3.1.1 18:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:46:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:46:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:46:52 INFO - Installing collected packages: psutil 18:46:52 INFO - Running setup.py install for psutil 18:46:52 INFO - building 'psutil._psutil_linux' extension 18:46:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:46:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:46:53 INFO - building 'psutil._psutil_posix' extension 18:46:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:46:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:46:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:46:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:46:53 INFO - Successfully installed psutil 18:46:53 INFO - Cleaning up... 18:46:53 INFO - Return code: 0 18:46:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:46:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:46:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:53 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 0x7fba1532ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a2f60>, '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 0x22a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a41d0>, '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': '745a4373a2a16df560f216e000000264-1475372789.598508-952381448', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:46:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:46:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:46:53 INFO - Using env: {'DISPLAY': ':0', 18:46:53 INFO - 'HOME': '/home/cltbld', 18:46:53 INFO - 'LANG': 'en_US.UTF-8', 18:46:53 INFO - 'LANGUAGE': 'en_US:en', 18:46:53 INFO - 'LOGNAME': 'cltbld', 18:46:53 INFO - 'MAIL': '/var/mail/cltbld', 18:46:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:53 INFO - 'MOZ_NO_REMOTE': '1', 18:46:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:53 INFO - 'NO_EM_RESTART': '1', 18:46:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:53 INFO - 'PWD': '/builds/slave/test', 18:46:53 INFO - 'SHELL': '/bin/bash', 18:46:53 INFO - 'SHLVL': '1', 18:46:53 INFO - 'TERM': 'linux', 18:46:53 INFO - 'TMOUT': '86400', 18:46:53 INFO - 'USER': 'cltbld', 18:46:53 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1475372789.598508-952381448', 18:46:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:53 INFO - '_': '/tools/buildbot/bin/python'} 18:46:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:46:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:46:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:46:55 INFO - Installing collected packages: mozsystemmonitor 18:46:55 INFO - Running setup.py install for mozsystemmonitor 18:46:55 INFO - Successfully installed mozsystemmonitor 18:46:55 INFO - Cleaning up... 18:46:55 INFO - Return code: 0 18:46:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:46: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')]} 18:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46: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')]} 18:46:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba1532ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a2f60>, '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 0x22a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a41d0>, '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': '745a4373a2a16df560f216e000000264-1475372789.598508-952381448', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:46: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==2.5.1'] in /builds/slave/test/build 18:46: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==2.5.1 18:46:55 INFO - Using env: {'DISPLAY': ':0', 18:46:55 INFO - 'HOME': '/home/cltbld', 18:46:55 INFO - 'LANG': 'en_US.UTF-8', 18:46:55 INFO - 'LANGUAGE': 'en_US:en', 18:46:55 INFO - 'LOGNAME': 'cltbld', 18:46:55 INFO - 'MAIL': '/var/mail/cltbld', 18:46:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:55 INFO - 'MOZ_NO_REMOTE': '1', 18:46:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:55 INFO - 'NO_EM_RESTART': '1', 18:46:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:55 INFO - 'PWD': '/builds/slave/test', 18:46:55 INFO - 'SHELL': '/bin/bash', 18:46:55 INFO - 'SHLVL': '1', 18:46:55 INFO - 'TERM': 'linux', 18:46:55 INFO - 'TMOUT': '86400', 18:46:55 INFO - 'USER': 'cltbld', 18:46:55 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1475372789.598508-952381448', 18:46:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:55 INFO - '_': '/tools/buildbot/bin/python'} 18:46:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:55 INFO - Downloading/unpacking jsonschema==2.5.1 18:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:46:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:58 INFO - Downloading functools32-3.2.3-2.tar.gz 18:46:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:46:58 INFO - warning: no files found matching '*.txt' 18:46:58 INFO - no previously-included directories found matching 'build' 18:46:58 INFO - no previously-included directories found matching 'dist' 18:46:58 INFO - no previously-included directories found matching '.git*' 18:46:58 INFO - Installing collected packages: jsonschema, functools32 18:46:58 INFO - Running setup.py install for functools32 18:46:58 INFO - warning: no files found matching '*.txt' 18:46:58 INFO - no previously-included directories found matching 'build' 18:46:58 INFO - no previously-included directories found matching 'dist' 18:46:58 INFO - no previously-included directories found matching '.git*' 18:46:58 INFO - Successfully installed jsonschema functools32 18:46:58 INFO - Cleaning up... 18:46:58 INFO - Return code: 0 18:46:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:46:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:46:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fba1532ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a2f60>, '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 0x22a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a41d0>, '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': '745a4373a2a16df560f216e000000264-1475372789.598508-952381448', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:46:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:46:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:46:58 INFO - Using env: {'DISPLAY': ':0', 18:46:58 INFO - 'HOME': '/home/cltbld', 18:46:58 INFO - 'LANG': 'en_US.UTF-8', 18:46:58 INFO - 'LANGUAGE': 'en_US:en', 18:46:58 INFO - 'LOGNAME': 'cltbld', 18:46:58 INFO - 'MAIL': '/var/mail/cltbld', 18:46:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:58 INFO - 'MOZ_NO_REMOTE': '1', 18:46:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:58 INFO - 'NO_EM_RESTART': '1', 18:46:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:58 INFO - 'PWD': '/builds/slave/test', 18:46:58 INFO - 'SHELL': '/bin/bash', 18:46:58 INFO - 'SHLVL': '1', 18:46:58 INFO - 'TERM': 'linux', 18:46:58 INFO - 'TMOUT': '86400', 18:46:58 INFO - 'USER': 'cltbld', 18:46:58 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1475372789.598508-952381448', 18:46:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:58 INFO - '_': '/tools/buildbot/bin/python'} 18:46:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:46:58 INFO - Cleaning up... 18:46:58 INFO - Return code: 0 18:46:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:46:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:46:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fba1532ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a2f60>, '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 0x22a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a41d0>, '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': '745a4373a2a16df560f216e000000264-1475372789.598508-952381448', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:46:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:46:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:46:58 INFO - Using env: {'DISPLAY': ':0', 18:46:58 INFO - 'HOME': '/home/cltbld', 18:46:58 INFO - 'LANG': 'en_US.UTF-8', 18:46:58 INFO - 'LANGUAGE': 'en_US:en', 18:46:58 INFO - 'LOGNAME': 'cltbld', 18:46:58 INFO - 'MAIL': '/var/mail/cltbld', 18:46:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:58 INFO - 'MOZ_NO_REMOTE': '1', 18:46:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:58 INFO - 'NO_EM_RESTART': '1', 18:46:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:58 INFO - 'PWD': '/builds/slave/test', 18:46:58 INFO - 'SHELL': '/bin/bash', 18:46:58 INFO - 'SHLVL': '1', 18:46:58 INFO - 'TERM': 'linux', 18:46:58 INFO - 'TMOUT': '86400', 18:46:58 INFO - 'USER': 'cltbld', 18:46:58 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1475372789.598508-952381448', 18:46:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:58 INFO - '_': '/tools/buildbot/bin/python'} 18:46:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:58 INFO - Downloading/unpacking blobuploader==1.2.4 18:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:00 INFO - Downloading blobuploader-1.2.4.tar.gz 18:47:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:47:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:47:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:01 INFO - Downloading docopt-0.6.1.tar.gz 18:47:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:47:01 INFO - Installing collected packages: blobuploader, requests, docopt 18:47:01 INFO - Running setup.py install for blobuploader 18:47:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:47:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:47:01 INFO - Running setup.py install for requests 18:47:01 INFO - Running setup.py install for docopt 18:47:01 INFO - Successfully installed blobuploader requests docopt 18:47:01 INFO - Cleaning up... 18:47:02 INFO - Return code: 0 18:47:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:02 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 0x7fba1532ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a2f60>, '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 0x22a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a41d0>, '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': '745a4373a2a16df560f216e000000264-1475372789.598508-952381448', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:47:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:47:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:47:02 INFO - Using env: {'DISPLAY': ':0', 18:47:02 INFO - 'HOME': '/home/cltbld', 18:47:02 INFO - 'LANG': 'en_US.UTF-8', 18:47:02 INFO - 'LANGUAGE': 'en_US:en', 18:47:02 INFO - 'LOGNAME': 'cltbld', 18:47:02 INFO - 'MAIL': '/var/mail/cltbld', 18:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:02 INFO - 'MOZ_NO_REMOTE': '1', 18:47:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:02 INFO - 'NO_EM_RESTART': '1', 18:47:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:47:02 INFO - 'PWD': '/builds/slave/test', 18:47:02 INFO - 'SHELL': '/bin/bash', 18:47:02 INFO - 'SHLVL': '1', 18:47:02 INFO - 'TERM': 'linux', 18:47:02 INFO - 'TMOUT': '86400', 18:47:02 INFO - 'USER': 'cltbld', 18:47:02 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1475372789.598508-952381448', 18:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:02 INFO - '_': '/tools/buildbot/bin/python'} 18:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:47:02 INFO - Running setup.py (path:/tmp/pip-vDQlNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:47:02 INFO - Running setup.py (path:/tmp/pip-xdoum1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:47:02 INFO - Running setup.py (path:/tmp/pip-sEIAkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:47:02 INFO - Running setup.py (path:/tmp/pip-TNjZbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:47:02 INFO - Running setup.py (path:/tmp/pip-quf7wj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:47:02 INFO - Running setup.py (path:/tmp/pip-Dgvr3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:47:02 INFO - Running setup.py (path:/tmp/pip-uou_1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:47:02 INFO - Running setup.py (path:/tmp/pip-h5UaRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:47:02 INFO - Running setup.py (path:/tmp/pip-oXFGIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:47:02 INFO - Running setup.py (path:/tmp/pip-C1UaS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:47:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:47:02 INFO - Running setup.py (path:/tmp/pip-hJVyFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:47:03 INFO - Running setup.py (path:/tmp/pip-AgRsr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:47:03 INFO - Running setup.py (path:/tmp/pip-vvmaQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:47:03 INFO - Running setup.py (path:/tmp/pip-RWU0h6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:47:03 INFO - Running setup.py (path:/tmp/pip-U3smwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:47:03 INFO - Running setup.py (path:/tmp/pip-QWvzys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:47:03 INFO - Running setup.py (path:/tmp/pip-LRhIxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:47:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:47:03 INFO - Running setup.py install for manifestparser 18:47:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:47:03 INFO - Running setup.py install for mozcrash 18:47:03 INFO - Running setup.py install for mozdebug 18:47:03 INFO - Running setup.py install for mozdevice 18:47:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:47:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:47:03 INFO - Running setup.py install for mozfile 18:47:03 INFO - Running setup.py install for mozhttpd 18:47:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:47:04 INFO - Running setup.py install for mozinfo 18:47:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:47:04 INFO - Running setup.py install for mozInstall 18:47:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:47:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:47:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:47:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:47:04 INFO - Running setup.py install for mozleak 18:47:04 INFO - Running setup.py install for mozlog 18:47:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:47:04 INFO - Running setup.py install for moznetwork 18:47:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:47:04 INFO - Running setup.py install for mozprocess 18:47:04 INFO - Running setup.py install for mozprofile 18:47:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:47:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:47:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:47:04 INFO - Running setup.py install for mozrunner 18:47:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:47:04 INFO - Running setup.py install for mozscreenshot 18:47:05 INFO - Running setup.py install for moztest 18:47:05 INFO - Running setup.py install for mozversion 18:47:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:47:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:47:05 INFO - Cleaning up... 18:47:05 INFO - Return code: 0 18:47:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:05 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 0x7fba1532ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a2f60>, '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 0x22a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a41d0>, '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': '745a4373a2a16df560f216e000000264-1475372789.598508-952381448', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:47:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:47:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:47:05 INFO - Using env: {'DISPLAY': ':0', 18:47:05 INFO - 'HOME': '/home/cltbld', 18:47:05 INFO - 'LANG': 'en_US.UTF-8', 18:47:05 INFO - 'LANGUAGE': 'en_US:en', 18:47:05 INFO - 'LOGNAME': 'cltbld', 18:47:05 INFO - 'MAIL': '/var/mail/cltbld', 18:47:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:05 INFO - 'MOZ_NO_REMOTE': '1', 18:47:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:05 INFO - 'NO_EM_RESTART': '1', 18:47:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:47:05 INFO - 'PWD': '/builds/slave/test', 18:47:05 INFO - 'SHELL': '/bin/bash', 18:47:05 INFO - 'SHLVL': '1', 18:47:05 INFO - 'TERM': 'linux', 18:47:05 INFO - 'TMOUT': '86400', 18:47:05 INFO - 'USER': 'cltbld', 18:47:05 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1475372789.598508-952381448', 18:47:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:05 INFO - '_': '/tools/buildbot/bin/python'} 18:47:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:47:05 INFO - Running setup.py (path:/tmp/pip-f4lo6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:47:05 INFO - Running setup.py (path:/tmp/pip-xijjF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:47:05 INFO - Running setup.py (path:/tmp/pip-Gi71rU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:47:05 INFO - Running setup.py (path:/tmp/pip-IPqvaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:47:05 INFO - Running setup.py (path:/tmp/pip-utmD74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:47:05 INFO - Running setup.py (path:/tmp/pip-5sK_dB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:47:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:47:05 INFO - Running setup.py (path:/tmp/pip-t0131L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:47:06 INFO - Running setup.py (path:/tmp/pip-78q96Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:47:06 INFO - Running setup.py (path:/tmp/pip-_sMIta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:47:06 INFO - Running setup.py (path:/tmp/pip-8XwH6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:47:06 INFO - Running setup.py (path:/tmp/pip-6COyv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:47:06 INFO - Running setup.py (path:/tmp/pip-zfR4o9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:47:06 INFO - Running setup.py (path:/tmp/pip-BySs1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:47:06 INFO - Running setup.py (path:/tmp/pip-fmSXaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:47:06 INFO - Running setup.py (path:/tmp/pip-Jfxt2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:47:06 INFO - Running setup.py (path:/tmp/pip-r8kgE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:47:06 INFO - Running setup.py (path:/tmp/pip-Sce0HW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:47:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:08 INFO - Downloading blessings-1.6.tar.gz 18:47:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:47:08 INFO - Installing collected packages: blessings 18:47:08 INFO - Running setup.py install for blessings 18:47:08 INFO - Successfully installed blessings 18:47:08 INFO - Cleaning up... 18:47:08 INFO - Return code: 0 18:47:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:47:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:47:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:47:09 INFO - Reading from file tmpfile_stdout 18:47:09 INFO - Current package versions: 18:47:09 INFO - argparse == 1.2.1 18:47:09 INFO - blessings == 1.6 18:47:09 INFO - blobuploader == 1.2.4 18:47:09 INFO - docopt == 0.6.1 18:47:09 INFO - functools32 == 3.2.3-2 18:47:09 INFO - jsonschema == 2.5.1 18:47:09 INFO - manifestparser == 1.1 18:47:09 INFO - mozInstall == 1.12 18:47:09 INFO - mozcrash == 0.17 18:47:09 INFO - mozdebug == 0.1 18:47:09 INFO - mozdevice == 0.48 18:47:09 INFO - mozfile == 1.2 18:47:09 INFO - mozhttpd == 0.7 18:47:09 INFO - mozinfo == 0.9 18:47:09 INFO - mozleak == 0.1 18:47:09 INFO - mozlog == 3.4 18:47:09 INFO - moznetwork == 0.27 18:47:09 INFO - mozprocess == 0.23 18:47:09 INFO - mozprofile == 0.28 18:47:09 INFO - mozrunner == 6.12 18:47:09 INFO - mozscreenshot == 0.1 18:47:09 INFO - mozsystemmonitor == 0.3 18:47:09 INFO - moztest == 0.7 18:47:09 INFO - mozversion == 1.4 18:47:09 INFO - psutil == 3.1.1 18:47:09 INFO - requests == 1.2.3 18:47:09 INFO - wsgiref == 0.1.2 18:47:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:47:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:09 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 0x7fba1532ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a2f60>, '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 0x22a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a41d0>, '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': '745a4373a2a16df560f216e000000264-1475372789.598508-952381448', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:47:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:47:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:47:09 INFO - Using env: {'DISPLAY': ':0', 18:47:09 INFO - 'HOME': '/home/cltbld', 18:47:09 INFO - 'LANG': 'en_US.UTF-8', 18:47:09 INFO - 'LANGUAGE': 'en_US:en', 18:47:09 INFO - 'LOGNAME': 'cltbld', 18:47:09 INFO - 'MAIL': '/var/mail/cltbld', 18:47:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:09 INFO - 'MOZ_NO_REMOTE': '1', 18:47:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:09 INFO - 'NO_EM_RESTART': '1', 18:47:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:47:09 INFO - 'PWD': '/builds/slave/test', 18:47:09 INFO - 'SHELL': '/bin/bash', 18:47:09 INFO - 'SHLVL': '1', 18:47:09 INFO - 'TERM': 'linux', 18:47:09 INFO - 'TMOUT': '86400', 18:47:09 INFO - 'USER': 'cltbld', 18:47:09 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1475372789.598508-952381448', 18:47:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:09 INFO - '_': '/tools/buildbot/bin/python'} 18:47:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:47:09 INFO - Cleaning up... 18:47:09 INFO - Return code: 0 18:47:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:47:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:09 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 0x7fba1532ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a2f60>, '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 0x22a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a41d0>, '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': '745a4373a2a16df560f216e000000264-1475372789.598508-952381448', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:47:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:47:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:47:09 INFO - Using env: {'DISPLAY': ':0', 18:47:09 INFO - 'HOME': '/home/cltbld', 18:47:09 INFO - 'LANG': 'en_US.UTF-8', 18:47:09 INFO - 'LANGUAGE': 'en_US:en', 18:47:09 INFO - 'LOGNAME': 'cltbld', 18:47:09 INFO - 'MAIL': '/var/mail/cltbld', 18:47:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:09 INFO - 'MOZ_NO_REMOTE': '1', 18:47:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:09 INFO - 'NO_EM_RESTART': '1', 18:47:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:47:09 INFO - 'PWD': '/builds/slave/test', 18:47:09 INFO - 'SHELL': '/bin/bash', 18:47:09 INFO - 'SHLVL': '1', 18:47:09 INFO - 'TERM': 'linux', 18:47:09 INFO - 'TMOUT': '86400', 18:47:09 INFO - 'USER': 'cltbld', 18:47:09 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1475372789.598508-952381448', 18:47:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:09 INFO - '_': '/tools/buildbot/bin/python'} 18:47:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:47:09 INFO - Cleaning up... 18:47:09 INFO - Return code: 0 18:47:09 INFO - Running post-action listener: _resource_record_post_action 18:47:09 INFO - Running post-action listener: _start_resource_monitoring 18:47:09 INFO - Starting resource monitoring. 18:47:09 INFO - [mozharness: 2016-10-02 01:47:09.598735Z] Finished create-virtualenv step (success) 18:47:09 INFO - [mozharness: 2016-10-02 01:47:09.599249Z] Running install step. 18:47:09 INFO - Running pre-action listener: _resource_record_pre_action 18:47:09 INFO - Running main action method: install 18:47:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:47:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:47:09 INFO - Reading from file tmpfile_stdout 18:47:09 INFO - Detecting whether we're running mozinstall >=1.0... 18:47:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:47:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:47:09 INFO - Reading from file tmpfile_stdout 18:47:09 INFO - Output received: 18:47:09 INFO - Usage: mozinstall [options] installer 18:47:09 INFO - Options: 18:47:09 INFO - -h, --help show this help message and exit 18:47:09 INFO - -d DEST, --destination=DEST 18:47:09 INFO - Directory to install application into. [default: 18:47:09 INFO - "/builds/slave/test"] 18:47:09 INFO - --app=APP Application being installed. [default: firefox] 18:47:09 INFO - mkdir: /builds/slave/test/build/application 18:47:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:47:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:47:26 INFO - Reading from file tmpfile_stdout 18:47:26 INFO - Output received: 18:47:26 INFO - /builds/slave/test/build/application/firefox/firefox 18:47:26 INFO - Running post-action listener: _resource_record_post_action 18:47:26 INFO - [mozharness: 2016-10-02 01:47:26.914972Z] Finished install step (success) 18:47:26 INFO - [mozharness: 2016-10-02 01:47:26.915287Z] Running run-tests step. 18:47:26 INFO - Running pre-action listener: _resource_record_pre_action 18:47:26 INFO - Running main action method: run_tests 18:47:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:47:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:47:26 INFO - Python 2.7.3 18:47:26 INFO - Return code: 0 18:47:26 INFO - grabbing minidump binary from tooltool 18:47:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:47:26 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 0x22a2f60>, '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 0x22a3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a41d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:47:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:47:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:47:26 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:47:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:47:26 INFO - Return code: 0 18:47:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:47:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:47:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:47:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:47:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:47:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fXj3d8e1Rc2-6D01XTVuqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 18:47:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fXj3d8e1Rc2-6D01XTVuqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 18:47:26 INFO - Using env: {'DISPLAY': ':0', 18:47:26 INFO - 'HOME': '/home/cltbld', 18:47:26 INFO - 'LANG': 'en_US.UTF-8', 18:47:26 INFO - 'LANGUAGE': 'en_US:en', 18:47:26 INFO - 'LOGNAME': 'cltbld', 18:47:26 INFO - 'MAIL': '/var/mail/cltbld', 18:47:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:47:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:47:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:27 INFO - 'MOZ_NO_REMOTE': '1', 18:47:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:47:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:27 INFO - 'NO_EM_RESTART': '1', 18:47:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:47:27 INFO - 'PWD': '/builds/slave/test', 18:47:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:47:27 INFO - 'SHELL': '/bin/bash', 18:47:27 INFO - 'SHLVL': '1', 18:47:27 INFO - 'TERM': 'linux', 18:47:27 INFO - 'TMOUT': '86400', 18:47:27 INFO - 'USER': 'cltbld', 18:47:27 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1475372789.598508-952381448', 18:47:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:27 INFO - '_': '/tools/buildbot/bin/python'} 18:47:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fXj3d8e1Rc2-6D01XTVuqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 18:47:27 INFO - mozversion application_buildid: 20161001153006 18:47:27 INFO - mozversion application_changeset: 0eed0d06ea6d4053f1f9f85ba6bc0e0db6b4eac6 18:47:27 INFO - mozversion application_display_name: Nightly 18:47:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:47:27 INFO - mozversion application_name: Firefox 18:47:27 INFO - mozversion application_remotingname: firefox 18:47:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:47:27 INFO - mozversion application_vendor: Mozilla 18:47:27 INFO - mozversion application_version: 52.0a1 18:47:27 INFO - mozversion platform_buildid: 20161001153006 18:47:27 INFO - mozversion platform_changeset: 0eed0d06ea6d4053f1f9f85ba6bc0e0db6b4eac6 18:47:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:47:27 INFO - mozversion platform_version: 52.0a1 18:47:27 INFO - using testdate: 1475372847 18:47:27 INFO - actual date: 1475372847 18:47:27 INFO - starting webserver on 'localhost:54473' 18:47:27 INFO - SUITE-START | Running 2 tests 18:47:27 INFO - TEST-START | dromaeo_css 18:47:27 INFO - operating with platform_type : linux_ 18:47:27 INFO - Initialising browser for dromaeo_css test... 18:47:27 INFO - TEST-INFO | started process 4088 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBm7JTT/profile http://localhost:54473/getInfo.html) 18:47:32 INFO - PROCESS | 4088 | __metrics Screen width/height:1600/1200 18:47:32 INFO - PROCESS | 4088 | colorDepth:24 18:47:32 INFO - PROCESS | 4088 | Browser inner width/height: 1024/697 18:47:32 INFO - PROCESS | 4088 | __metrics 18:47:32 INFO - PROCESS | 4088 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:47:32 INFO - PROCESS | 4088 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:47:33 INFO - PROCESS | 4088 | console.error: PushService: 18:47:33 INFO - PROCESS | 4088 | stateChangeProcessEnqueue: Error transitioning state 18:47:33 INFO - PROCESS | 4088 | UnknownError 18:47:33 INFO - TEST-INFO | 4088: exit 0 18:47:33 INFO - Browser initialized. 18:47:33 INFO - Running cycle 1/1 for dromaeo_css test... 18:47:33 INFO - TEST-INFO | started process 4171 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBm7JTT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:47:46 INFO - PROCESS | 4171 | RSS: Main: 178008064 18:47:46 INFO - PROCESS | 4171 | 18:48:37 INFO - PROCESS | 4171 | 1475372917648 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:50:48 INFO - PROCESS | 4171 | Cycle 1(1): loaded http://localhost:54473/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54473/tests/dromaeo/cssquery-ext.html) 18:50:49 INFO - PROCESS | 4171 | RSS: Main: 318005248 18:50:49 INFO - PROCESS | 4171 | 18:53:52 INFO - PROCESS | 4171 | Cycle 1(1): loaded http://localhost:54473/tests/dromaeo/cssquery-ext.html (next: http://localhost:54473/tests/dromaeo/cssquery-jquery.html) 18:53:52 INFO - PROCESS | 4171 | RSS: Main: 286973952 18:53:52 INFO - PROCESS | 4171 | 18:56:54 INFO - PROCESS | 4171 | Cycle 1(1): loaded http://localhost:54473/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54473/tests/dromaeo/cssquery-mootools.html) 18:56:55 INFO - PROCESS | 4171 | RSS: Main: 248557568 18:56:55 INFO - PROCESS | 4171 | 18:59:57 INFO - PROCESS | 4171 | Cycle 1(1): loaded http://localhost:54473/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54473/tests/dromaeo/cssquery-prototype.html) 18:59:57 INFO - PROCESS | 4171 | RSS: Main: 273158144 18:59:57 INFO - PROCESS | 4171 | 19:03:00 INFO - PROCESS | 4171 | Cycle 1(1): loaded http://localhost:54473/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54473/tests/dromaeo/cssquery-yui.html) 19:03:01 INFO - PROCESS | 4171 | RSS: Main: 216952832 19:03:01 INFO - PROCESS | 4171 | 19:06:03 INFO - PROCESS | 4171 | Cycle 1(1): loaded http://localhost:54473/tests/dromaeo/cssquery-yui.html (next: http://localhost:54473/tests/dromaeo/cssquery-dojo.html) 19:06:04 INFO - PROCESS | 4171 | RSS: Main: 306225152 19:06:04 INFO - PROCESS | 4171 | 19:06:04 INFO - PROCESS | 4171 | __start_tp_report 19:06:04 INFO - PROCESS | 4171 | _x_x_mozilla_page_load 19:06:04 INFO - PROCESS | 4171 | _x_x_mozilla_page_load_details 19:06:04 INFO - PROCESS | 4171 | |i|pagename|runs| 19:06:04 INFO - PROCESS | 4171 | |0;dojo.html;2955.4827905116604;3005.053408176425;3009.774266929981;3033.120395085425;3054.786164968452;5227.634065615409;5269.76286067127;5306.89386212276;5412.107002344614;5426.186072089184;5324.494173053564;5328.813491527797;5337.359516857973;5353.411124776271;5362.678239305645;4804.087223427555;4826.951730482703;4900.215965445529;4901.828436004741;4930.03864246472;4817.614590832725;4855.368802055727;4887.2913427552985;4927.876803079916;4997.125503036972;4796.44840843304;4902.632302577304;4925.285833554132;4938.407391113072;4983.9252411213865;4865.854024379274;4913.803447862099;4919.385076865392;4943.752812359367;4966.304717339575;4704.1767690654;4738.786754596052;4758.547937945889;4787.329773831666;4822.180229361017;5268.209768534751;5279.445658205871;5286.867828304285;5345.786168553253;5373.838784836461;5629.071203251458;5671.092625179951;5673.404292549264;5692.260006199209;5693.373728889819;5510.1459273812625;5535.529479994206;5650.237217975603;5704.402767225183;5775.711214439303;5338.199270109515;5338.599605029638;5356.0626890294825;5393.703346315951;5402.594805389572;5808.79669211584;5814.040683287295;5818.912716309259;5819.6508209507565;5822.737976791054;5422.43064478232;5476.288082549323;5582.106862901916;5602.13166959122;5605.607607467438;5608;5689.118186681071;5700.857478562986;5720.1991721159075;5789;5648.604597678205;5656;5689.0328644130595;5701.315842098975;5701.857453563694;5486.067368547357;5715.31416230055;5728.398518155617;5731.197632331477;5779.826605201851;4320.200762858881;4354.433923589913;4361.498427680857;4364.803583838735;4372.715773474714;3858.305505009125;3862.8261728222296;3863.8068096595057;3906.4921560196995;3906.8865373368453;5373.817760092773;5374.838754837283;5376.38171610262;5376.838694839161;5424.240606315119;5482.342118945752;5529.419410961871;5537.723113844291;5615.101583746581;5700.8859822803315;5243.475652434802;5311.044012077863;5312.654677446031;5314.548263397577;5321.441248668912;4854.271859221074;4880.438749543777;4897.216445368796;4897.804087836446;4899.2896030075435;5784.4504772046585;5792.681402522901;5800.622959507703;5810.157527158538;5814.476697097197;5602.523785478117;5605.495505404533;5620.775168993358;5622.409646987007;5626.493615574618;5798.5651076168615;5799.594028417971;5802;5802.5357971361345;5802.564807639359;5459.235707001102;5467.535259502987;5548.722563871871;5558.305211848519;5576.470235327637;5724.169995350568;5731.111677689964;5734.369219385948;5738.856528586652;5739.253896993364;5319.760610772602;5413.56691464674;5581.804636837691;5590.748416321194;5593.272874526286;5435.2934118564335;5503.284573005483;5510.338759348904;5535.667859928256;5597.748101335531;5481.5340696041285;5483.122700367922;5484.204790305464;5484.287042684426;5486.972565137149;5413.648112872651;5447.645903016291;5569.66582005081;5591.161325801162;5591.748371323219;5499.120140777456;5547.362053363915;5583;5589.748461319169;5590 19:06:04 INFO - PROCESS | 4171 | |1;ext.html;548.601603755134;588.5174157191102;592.218271881117;594.8037147741246;610.0391882784614;31148.844255778717;41863.581364186386;42221.57778422215;42227.577724222785;42298.924129104475;43717.12565748683;44202;44286;44290;44315.33526997089;8118.431709780318;8882.777930551756;9045.3668243223;9054.4114632549;9058.592363343665;8092.635831387573;10485.213608979318;10740.516676749565;10741.731456713605;11145.21983461158;10911.618093366733;10971.23201375904;10976.341419514814;10978.560857565688;10979.2863463875;10747.570097196103;10811.945940270249;10813.945930270338;10828.72928176794;10834.295770774874;10626.468676566217;10696.78606427867;10699;10701.09040731531;10702.839457408145;42580.78709606432;42875.57124428747;42916.57083429188;42927.78536107331;42947.35578966318;3495.528103706018;3521.418965870628;3631.636836316374;3642.488367327556;4107.486564179478;31546.369072618418;31907.84046079778;31945.52081718776;32044.359112817845;32463.83768081168;4202.117555313357;4274.914501709948;4321.330193819931;4399.5380485049245;4462.12988467249;324982;325852;326261;326969;328417;34365.65634343675;56683;57086.42913570811;57104.42895571074;57161;35192.64807351894;37339.81330093386;37456.43815342772;37567.81216093902;37576.24847503035;15880.60298492547;16011.679766404606;16026.11856347912;16032.599185020235;16032.919835400748;11847.466863991142;12302.261864288172;13053.804192937114;13410.195388276734;13496.797548036788;8436.535990520457;8442.662293508314;8501.489910605384;8620.612072456754;8624.525651089125;3251.3009702913987;3294.5387645729616;3314.6022477302395;3325.384803811254;3361.647027062172;997.152420442618;1009.3590569988111;1077.21363404715;1129.1869853705318;1151.090638395675;31131.042550957623;31267.374652506824;31319;31370.14437265719;31457.21356966094;1058.523664351045;1076.612419528969;1114.164376717462;1120.523777394604;1182.0779791762438;16264.75602865958;16724.331026759035;16934.49196524106;16940.83059169417;17140;505045;506865;508051;509204;511725;57665.423345766845;57694.423055769745;58233.70883145642;58273;58344.70827645835;1203.2720204276286;1218.2933898338943;1240.925544467335;1351.9324033798468;1354.573309407553;30375.24061898382;31770.841145794122;32519.512207316435;32831.83584082064;33523.329533409684;48680.5131948676;49506;49971.75014124906;50007.74996124996;50013.99972000467;392007;392562;392858;393239;393533;27500.862495687394;28500.57249141306;28581.28546786264;29734.702652974058;30021.399572008002;46729.76635116803;47094.52905470901;47099.764501178644;47229.2915606273;49494.75252623714;39733;40223.396649050876;40812.59187408088;41049.79475102725;42628.78685606552;38968.647524593325;39126;39427;40779.38830917479;41274;38881.805590972996;39990.40014399844;40850.38724419195;40999.38500922429;41009.589904100576;31044.379112418075;34872.82563587166;35996.64003359933;38357.61642383652;38620.227595448494;27709;27852.72147278501;27885.860570697827;28098.87604495797;28128.43743125085 19:06:04 INFO - PROCESS | 4171 | |2;jquery.html;381.96371344722274;396.8531643291981;401.6425381410545;409.5188153919145;426.4520091682189;13257.33713314334;15346.69306613867;19039.61920761584;19120.904395478003;19787.109580068896;18503.814961850378;18868.245270189174;18996.525086872836;19020.714689279674;19394.51513712158;5512.090505066679;5694.886102277952;5935.465808077272;5944.464998150165;5949.762009519614;5679.886402271952;5856.267966504187;5857.326407463132;5859.326177489601;5861.618994765348;3740.6446387593273;3965.385365268388;5651.378348381675;5878.88242235155;5922.703864806743;5770.538356931435;5879.412058794129;6008.098785182214;6013.909791353133;6021.397860213965;5606.439356064361;5636.070048442002;5641.238432811559;5643.097104463266;5647.661140331593;13544.525941591997;13650.93174534131;13779.966502512352;14785.926070369687;21996.780032199633;2228.0864845413466;2248.2580748353002;2309.261036468331;2427.7693619106158;2835.9858200708863;10095.798084038279;10296.691099267035;12123.636290911287;14031.78952315716;14049.578512644637;1854.3695143651223;1881.2264722533978;1884.2839720905968;1889.3765057530982;1979.8218160365493;72335.27664723338;74371.99999999946;76348.61825690836;79230;79594;10568.471576421149;10647.787044259072;10700.30448020876;10787.514561844579;11171.888281117248;15652;15668.294926728324;15692.843071569137;15707.957965464417;15717.528474145794;7708.421868359896;7937.642806073741;7985.241402066795;8307.418480706414;8317.334613230927;7714.961425192838;7740.574268415291;7761.107472640606;7964.6415911282975;7987.041555013436;4567.109413664303;4583.977080114578;4607.101615185007;4643.744594047293;4798;1918.3765276285262;1919.1459800388693;1952.687569988795;1967.3114409956686;1974.0524548216936;864.8832407625016;934.4019827310527;939.1266122505998;939.7039932421266;986.1765425869336;17475.456381340944;18751.24995000212;19079.80920190808;19256.70612917734;19440;945.0360632155164;955.302629080775;974.3617930255693;984.227381505529;991.7818080022528;9979.50102494887;10686;10801.83797243042;10850.403227822546;10897;468089;473315;476340;483497;483783;62404.68797655983;84287.57856210679;84729.57635211785;85000.57499712461;88212.5589372049;952.6618050592078;959.7504648791364;992.8014397120605;998.2762497189625;1003.9096481316717;16011;16527.83472165263;16980;17000.65998680044;17315.826841731927;39672;39950.200995979336;40045;40390.52775236591;41007.58992410038;49882.75058624829;52070;52377.7381113092;52545;54128;8437.535935523605;11332.093432525213;11518.424078795859;12005.650422533721;12412.62762117138;13329.733405331644;13499.797503037658;13655.658608534468;14131.505397311044;14341.92829035848;12050.457729402022;12082.577109801467;12299.877001229874;12439;12532.49870005226;12068.818967715666;12119.75760484803;12165;12189.329586872453;12508.687282817638;6110.816675499742;8077.919220807717;11089.780124186173;11756.447276709941;12175.878241217828;12208.084393670333;12235.816462752888;12240.755184896074;12409.751804964031;12613.117081804186;11994.820077698667;12276.202046867282;12330.260184388966;12617;12719.173253738478 19:06:04 INFO - PROCESS | 4171 | |3;mootools.html;1315.7828958221894;1412.4041618313647;1444.761614333635;1556.6419723463603;1716.9399071032508;7789.8831517527215;8850.91149088509;9192.770180745485;9199.816003679922;9539.09378609031;9296.488693121875;9376.343655944069;9383.671571494999;9384.8592271116;9394.483303418308;2344.6834677318598;2353.670486131943;2371.9644205336936;2375.406148462884;2381.4879800842814;2295.8163346932206;2310.445493081657;2374.3114496795906;2378.9048438062455;2383.940401489959;2321.7562155973633;2323.6282194848827;2343.8593684378907;2363.09021026905;2365.042157926043;2243.596152692515;2245.6070187717246;2283.6460348645905;2288.2906299047268;2294.529621427612;2293.1629955066446;2295.540891821642;2296.552172326397;2303.7465878753324;2304.0783686525524;9274.860877086849;9336.859947100798;9337.253019758471;9341.065893410672;9476.810463790755;5461.535769459561;5569.805056823032;5572.832815015556;5585.832425027255;5589.832305030855;3443.6900678938764;3465.081753335368;3475.461303497962;3489.91275218119;3529.6293889141784;1141.7545227776068;1169.4152923538231;1178.2047118195185;1183.3905538647518;1189.9821502677466;12946.741065178643;13171.670708232276;13238.53665121716;13248.20510769357;13266.40301186449;4406.25093734066;4514.413126293561;4702.130105930414;4709.811607535728;4713.175194340976;9880.061394167542;9889.258305626963;9895.60417583303;9897.01029897019;9906.356086854332;5478.041342765;5489.58828087887;5491.9725401373535;5494;5496.065668836308;4506.459224892968;4650.255959046604;4926.236433352764;5023.34696489454;5131.1277082895995;3766.1902690921584;3791.241751649681;3893.824777885002;3894.4742459768136;3901.1612503311926;1102;1126.1722633864267;1128.328644456547;1128.887111288881;1144.0618692672097;694.4999600287784;819.8319344534356;852.1946760311446;905.4160066756905;915.0163574157807;5583.692896890629;5656.5757568181725;5782.855428614234;5930.140129681172;6079.513638908877;405.6997821612045;411.7611785164597;413.6566649680758;430.55222568529007;441.1750027448692;3745.513083299208;3804.771713697187;3822.445745366906;3854.8265328060306;4012.799360031987;11383.829242561369;11683.182177247681;11906.583269585522;11916.225445346025;11917.22538035025;11402.828957565644;11498.827517587242;11700.180987330976;11840.822387664191;11873.940630296966;8522.573871306535;8581.442206256574;8639.352048596254;8651;8651.567421629019;5674.744636491285;5749.367569567428;5780.248567686174;5806.390329015392;5992.520598352208;10477.16182705397;10763.300385474919;10876.075533579735;10932.890671093188;10945.343279403261;11100.833487497855;11110.722231944266;11128.109751219721;11134.220604557604;11135;6804.4556435484055;6884.724611015704;7335.083114610674;7810.179931107152;7846.293833555007;8985.281177505914;9079.68221112258;9115.270778337584;9162.816743665222;9188.127127922837;7759.72840950564;8020.117787043538;8105.716299929474;8240.258376746122;8329.625166867385;7759.495632783851;7880.960595196987;7928.603569821601;7982.6008699565955;8020.919790802017;7056.6118863463;7095.113110861143;7177.2463891292755;7182.676779545038;7188.676509557187;4928.802847886188;5063.87340316495;5096.286519887293;5264.420913699567;5448.863778405572;4893.975530122327;4912.45962944083;5120.385553733576;5220.869478263074;5366.892662146657 19:06:04 INFO - PROCESS | 4171 | |4;prototype.html;323.16761121325277;332.99269709129885;342.477721474751;346.3713360251145;346.50622862421045;5237.790488380465;5238;5315.36215654121;5332.760025798839;5382.515573598375;5244.711540865251;5262.2632831403635;5262.342207224097;5269.86825329367;5276.868078298045;4160.251154792136;4161.542230354658;4176.102138040321;4206.41110244566;4238.766867822269;3840.9807950960208;3944.3294639911283;4077.5922407759285;4103.897402564945;4124.690648201382;4079.388091786241;4093;4096.85661001865;4104.897377565555;4109.301418758818;4085.836566537335;4096.97951510242;4112.444819949298;4128.60778226068;4141.855035073788;3441.1913200397885;3463.3246516928957;3624.963750362489;3644.9976256529403;3653.762505437138;5053.267276244961;5066.265391518246;5072.771725272371;5074.923876141861;5078.695278283315;4694.08465349257;4702.553257440538;4723.645726570521;4723.787429565644;4741.146593613148;5342.435630897152;5391.406945236021;5393.568514518829;5428.972855135738;5432.70120143392;3984.7609143451486;4013.618706222904;4013.979930100331;4016.6786657067364;4030.7984600769846;5600.915986260209;5605.467480589337;5611.438856114356;5612.466815652507;5630.746616402272;3931.312020396419;4055.9391609125887;4059.2693315203546;4073.551909289976;4093.7543747375253;4115.794210289474;4152.480939882515;4182.937255941163;4183.560726123774;4192.685548583869;4682.979478236586;4709.670323077352;4722.126406614787;4748.596369308648;4754.478566858572;5188.948110518922;5442.972785136049;5523.972380138073;5539.362973258047;5548.445155484419;1397.7833435817465;1413.9151650900978;1415.6814716688662;1419.2974477633638;1424.1099312929418;884.2969838978028;909.2362415570952;918.4168053286078;925.9768505787274;933.6125507914139;4718.2214934536105;4736.9578692687555;4748.525147485224;4753.619710423158;5044.268581055726;5458.072127738294;5472.808451704172;5563.248961390242;5590.580706446952;5607.8598035048635;5263.34208223972;5275.86568887691;5277.736113194325;5284.867878303073;5304.363476382859;2846.51609226432;2951.070412819955;2951.8671659775364;2961.7926745128066;2968.539876319174;5742.712864356766;5747.051736463437;5764;5774.220480235114;5790.420957904176;5628.662280263197;5669.348024977098;5715.942840571624;5763.538916886723;5773.191753154561;5484.396716361197;5763.36602973681;5800.622959507618;5815.389384114607;5839.649621022667;5615.613364320066;5622.7750889963945;5641.633293835887;5683.090705487102;5765.164051212634;5400;5558.805441809517;5601.747921343468;5661.603687741983;5700.287464066992;5823.475887170175;5825.2135961644635;5837.795677151279;5858.86151554688;5867.5305975521005;4148.8133034012935;4180.310248808913;4228.450301460791;4228.915421691488;4233.661307095486;5471.79620483493;5582.794796055617;5593.972030139823;5597.384287728265;5695.1457281406465;5370.704611246419;5450.8909821802545;5454.445483037315;5454.918176227439;5470.17947307907;5414.174894921253;5475.808346707846;5495.752691128989;5531.557475401878;5551.641257039433;5312.362516498045;5413.945860541502;5415.35015798091;5418.214358917856;5419.132938729785;5264.710440925633;5493.802479008428;5508.779648814003;5526.557875370041;5562.443755624405;5196.68819870809;5284.233786100917;5395.56835453155;5398.514133727984;5405.5135037846785 19:06:04 INFO - PROCESS | 4171 | |5;yui.html;669.7856685860525;683.7811900191938;707.2220557386878;715.7494876793123;723.797336745711;14093.506727264536;15423;15431;15438.922805385986;15506.14716190609;12742.490300387997;12783.424745886434;12791.680207994805;12839.871601283985;12949.028822838301;640.0559175216541;658.1312667279169;764.1059959846965;767.5126294802812;785.7367781793106;779.4894344204555;795.1730200591378;796.4822865137678;796.6693822063836;797.6769408389612;828.5732847583499;833.6415341403194;834.3533761334984;834.3867257565685;834.4909605140859;654.9541532092732;676.9796906092826;796.8764841449585;831.7920519870032;832.21355818751;592.7066102279356;593.9524838012949;594.8334466349429;596.5049009322252;596.8120042186697;12943.611691649265;12973.870261297361;12977.610671679864;12992.675183120404;13032.86967130326;12425.31660758667;12629.87370126296;12663.746725065539;12960.935195324057;13238.27189504577;11968.82046769299;12139.210951288227;12180.939095304555;12251.790082497262;12448.190867593577;4292.3992278643655;4335.739855608674;4337.132573485315;4412.40432541606;4442.133783912106;69394.30605693928;74630.62684686542;74987.99999999946;75953;78648;10379.688609341732;10565.524551395205;10653.573857045787;10831.404272764916;11107;19925.10337034837;19938.90030549838;19966.401007969784;20032.198712051646;20246.797532024786;7770.339521140653;7777.688892444352;7869.842603147905;7941.483803552751;7995.360371170293;4270.316749320094;4394.143142087262;4417.425734654538;4432.29083346663;4456.286994080931;3409.4374428219066;3462.117160124152;3487.5814902211896;3488.319777643386;3496.8251587420527;616.7687117331001;617.7065893700546;630.0612087988864;641.2433328672118;646.0922404022356;586.2115454713404;595.1221947627301;599.66718471248;602.3765402808073;609.9878002439926;7934.1629071438965;8267.8346433071;8354.791130221793;8386.916130838736;8585.270252028522;564.8390208790476;566.6852901269099;587.6474115530648;587.7149582452507;615.9322474527798;3939.6060393960374;4052.8378864845076;4075.694322925792;4078.1232035112;4129.380592911088;119214.4039279798;120800.2756127642;122563;122717;123346;66913.66543167351;104759;105231.47384263182;107935.46032269788;112603;77674;93010.53494732484;94547.52726236325;94626;94806.15581532565;8580.91419085826;8768.123187681182;8949.507777072064;9072.364934454525;9088.182063614306;49161.754191228814;50130;50461.747691261306;51130.233046503585;51208;69664.30335696579;73019.63490182515;76575.61712191404;78801;78973.21026789659;10911;10940.890591093987;10987.61543345979;11089.445527723743;11288.887111128784;12366.567170149001;12419.565315213924;12975.480980760663;14543.563693089225;14559.563213103624;12226.449809758404;12777.105602607728;12903.51337698219;12988.675283117998;12995.610131696065;12434.564790232298;12527.80020506524;12601.054920880788;12947;12972.156809807333;12288.447019883948;12421.378931053592;12893.677658058623;13044.804327934899;13397.330133493091;10376.273660843668;11029.558817647205;11152.442377881236;11289.20975531705;11435.199536032398;9286.34995550332;10805.243632945618;10945.726356841144;11006.174536909604;11059.447027648424 19:06:04 INFO - PROCESS | 4171 | __end_tp_report 19:06:04 INFO - PROCESS | 4171 | __start_cc_report 19:06:04 INFO - PROCESS | 4171 | _x_x_mozilla_cycle_collect,1274 19:06:04 INFO - PROCESS | 4171 | __end_cc_report 19:06:04 INFO - PROCESS | 4171 | __startTimestamp1475373964226__endTimestamp 19:06:04 INFO - PROCESS | 4171 | 19:06:04 INFO - PROCESS | 4171 | ------- Summary: start ------- 19:06:04 INFO - PROCESS | 4171 | Number of tests: 6 19:06:04 INFO - PROCESS | 4171 | 19:06:04 INFO - PROCESS | 4171 | [#0] dojo.html Cycles:165 Average:5269.35 Median:5467.54 stddev:592.14 (10.8%) stddev-sans-first:565.45 19:06:04 INFO - PROCESS | 4171 | Values: 2955.5 3005.1 3009.8 3033.1 3054.8 5227.6 5269.8 5306.9 5412.1 5426.2 5324.5 5328.8 5337.4 5353.4 5362.7 4804.1 4827.0 4900.2 4901.8 4930.0 4817.6 4855.4 4887.3 4927.9 4997.1 4796.4 4902.6 4925.3 4938.4 4983.9 4865.9 4913.8 4919.4 4943.8 4966.3 4704.2 4738.8 4758.5 4787.3 4822.2 5268.2 5279.4 5286.9 5345.8 5373.8 5629.1 5671.1 5673.4 5692.3 5693.4 5510.1 5535.5 5650.2 5704.4 5775.7 5338.2 5338.6 5356.1 5393.7 5402.6 5808.8 5814.0 5818.9 5819.7 5822.7 5422.4 5476.3 5582.1 5602.1 5605.6 5608.0 5689.1 5700.9 5720.2 5789.0 5648.6 5656.0 5689.0 5701.3 5701.9 5486.1 5715.3 5728.4 5731.2 5779.8 4320.2 4354.4 4361.5 4364.8 4372.7 3858.3 3862.8 3863.8 3906.5 3906.9 5373.8 5374.8 5376.4 5376.8 5424.2 5482.3 5529.4 5537.7 5615.1 5700.9 5243.5 5311.0 5312.7 5314.5 5321.4 4854.3 4880.4 4897.2 4897.8 4899.3 5784.5 5792.7 5800.6 5810.2 5814.5 5602.5 5605.5 5620.8 5622.4 5626.5 5798.6 5799.6 5802.0 5802.5 5802.6 5459.2 5467.5 5548.7 5558.3 5576.5 5724.2 5731.1 5734.4 5738.9 5739.3 5319.8 5413.6 5581.8 5590.7 5593.3 5435.3 5503.3 5510.3 5535.7 5597.7 5481.5 5483.1 5484.2 5484.3 5487.0 5413.6 5447.6 5569.7 5591.2 5591.7 5499.1 5547.4 5583.0 5589.7 5590.0 19:06:04 INFO - PROCESS | 4171 | 19:06:04 INFO - PROCESS | 4171 | [#1] ext.html Cycles:180 Average:56373.83 Median:19814.14 stddev:110188.67 (556.1%) stddev-sans-first:110418.06 19:06:04 INFO - PROCESS | 4171 | Values: 548.6 588.5 592.2 594.8 610.0 31148.8 41863.6 42221.6 42227.6 42298.9 43717.1 44202.0 44286.0 44290.0 44315.3 8118.4 8882.8 9045.4 9054.4 9058.6 8092.6 10485.2 10740.5 10741.7 11145.2 10911.6 10971.2 10976.3 10978.6 10979.3 10747.6 10811.9 10813.9 10828.7 10834.3 10626.5 10696.8 10699.0 10701.1 10702.8 42580.8 42875.6 42916.6 42927.8 42947.4 3495.5 3521.4 3631.6 3642.5 4107.5 31546.4 31907.8 31945.5 32044.4 32463.8 4202.1 4274.9 4321.3 4399.5 4462.1 324982.0 325852.0 326261.0 326969.0 328417.0 34365.7 56683.0 57086.4 57104.4 57161.0 35192.6 37339.8 37456.4 37567.8 37576.2 15880.6 16011.7 16026.1 16032.6 16032.9 11847.5 12302.3 13053.8 13410.2 13496.8 8436.5 8442.7 8501.5 8620.6 8624.5 3251.3 3294.5 3314.6 3325.4 3361.6 997.2 1009.4 1077.2 1129.2 1151.1 31131.0 31267.4 31319.0 31370.1 31457.2 1058.5 1076.6 1114.2 1120.5 1182.1 16264.8 16724.3 16934.5 16940.8 17140.0 505045.0 506865.0 508051.0 509204.0 511725.0 57665.4 57694.4 58233.7 58273.0 58344.7 1203.3 1218.3 1240.9 1351.9 1354.6 30375.2 31770.8 32519.5 32831.8 33523.3 48680.5 49506.0 49971.8 50007.7 50014.0 392007.0 392562.0 392858.0 393239.0 393533.0 27500.9 28500.6 28581.3 29734.7 30021.4 46729.8 47094.5 47099.8 47229.3 49494.8 39733.0 40223.4 40812.6 41049.8 42628.8 38968.6 39126.0 39427.0 40779.4 41274.0 38881.8 39990.4 40850.4 40999.4 41009.6 31044.4 34872.8 35996.6 38357.6 38620.2 27709.0 27852.7 27885.9 28098.9 28128.4 19:06:04 INFO - PROCESS | 4171 | 19:06:04 INFO - PROCESS | 4171 | [#2] jquery.html Cycles:180 Average:27934.19 Median:2631.88 stddev:78361.16 (2977.4%) stddev-sans-first:78553.68 19:06:04 INFO - PROCESS | 4171 | Values: 382.0 396.9 401.6 409.5 426.5 13257.3 15346.7 19039.6 19120.9 19787.1 18503.8 18868.2 18996.5 19020.7 19394.5 5512.1 5694.9 5935.5 5944.5 5949.8 5679.9 5856.3 5857.3 5859.3 5861.6 3740.6 3965.4 5651.4 5878.9 5922.7 5770.5 5879.4 6008.1 6013.9 6021.4 5606.4 5636.1 5641.2 5643.1 5647.7 13544.5 13650.9 13780.0 14785.9 21996.8 2228.1 2248.3 2309.3 2427.8 2836.0 10095.8 10296.7 12123.6 14031.8 14049.6 1854.4 1881.2 1884.3 1889.4 1979.8 72335.3 74372.0 76348.6 79230.0 79594.0 10568.5 10647.8 10700.3 10787.5 11171.9 15652.0 15668.3 15692.8 15708.0 15717.5 7708.4 7937.6 7985.2 8307.4 8317.3 7715.0 7740.6 7761.1 7964.6 7987.0 4567.1 4584.0 4607.1 4643.7 4798.0 1918.4 1919.1 1952.7 1967.3 1974.1 864.9 934.4 939.1 939.7 986.2 17475.5 18751.2 19079.8 19256.7 19440.0 945.0 955.3 974.4 984.2 991.8 9979.5 10686.0 10801.8 10850.4 10897.0 468089.0 473315.0 476340.0 483497.0 483783.0 62404.7 84287.6 84729.6 85000.6 88212.6 952.7 959.8 992.8 998.3 1003.9 16011.0 16527.8 16980.0 17000.7 17315.8 39672.0 39950.2 40045.0 40390.5 41007.6 49882.8 52070.0 52377.7 52545.0 54128.0 8437.5 11332.1 11518.4 12005.7 12412.6 13329.7 13499.8 13655.7 14131.5 14341.9 12050.5 12082.6 12299.9 12439.0 12532.5 12068.8 12119.8 12165.0 12189.3 12508.7 6110.8 8077.9 11089.8 11756.4 12175.9 12208.1 12235.8 12240.8 12409.8 12613.1 11994.8 12276.2 12330.3 12617.0 12719.2 19:06:04 INFO - PROCESS | 4171 | 19:06:04 INFO - PROCESS | 4171 | [#3] mootools.html Cycles:180 Average:5957.50 Median:4711.49 stddev:3562.43 (75.6%) stddev-sans-first:3555.35 19:06:04 INFO - PROCESS | 4171 | Values: 1315.8 1412.4 1444.8 1556.6 1716.9 7789.9 8850.9 9192.8 9199.8 9539.1 9296.5 9376.3 9383.7 9384.9 9394.5 2344.7 2353.7 2372.0 2375.4 2381.5 2295.8 2310.4 2374.3 2378.9 2383.9 2321.8 2323.6 2343.9 2363.1 2365.0 2243.6 2245.6 2283.6 2288.3 2294.5 2293.2 2295.5 2296.6 2303.7 2304.1 9274.9 9336.9 9337.3 9341.1 9476.8 5461.5 5569.8 5572.8 5585.8 5589.8 3443.7 3465.1 3475.5 3489.9 3529.6 1141.8 1169.4 1178.2 1183.4 1190.0 12946.7 13171.7 13238.5 13248.2 13266.4 4406.3 4514.4 4702.1 4709.8 4713.2 9880.1 9889.3 9895.6 9897.0 9906.4 5478.0 5489.6 5492.0 5494.0 5496.1 4506.5 4650.3 4926.2 5023.3 5131.1 3766.2 3791.2 3893.8 3894.5 3901.2 1102.0 1126.2 1128.3 1128.9 1144.1 694.5 819.8 852.2 905.4 915.0 5583.7 5656.6 5782.9 5930.1 6079.5 405.7 411.8 413.7 430.6 441.2 3745.5 3804.8 3822.4 3854.8 4012.8 11383.8 11683.2 11906.6 11916.2 11917.2 11402.8 11498.8 11700.2 11840.8 11873.9 8522.6 8581.4 8639.4 8651.0 8651.6 5674.7 5749.4 5780.2 5806.4 5992.5 10477.2 10763.3 10876.1 10932.9 10945.3 11100.8 11110.7 11128.1 11134.2 11135.0 6804.5 6884.7 7335.1 7810.2 7846.3 8985.3 9079.7 9115.3 9162.8 9188.1 7759.7 8020.1 8105.7 8240.3 8329.6 7759.5 7881.0 7928.6 7982.6 8020.9 7056.6 7095.1 7177.2 7182.7 7188.7 4928.8 5063.9 5096.3 5264.4 5448.9 4894.0 4912.5 5120.4 5220.9 5366.9 19:06:04 INFO - PROCESS | 4171 | 19:06:04 INFO - PROCESS | 4171 | [#4] prototype.html Cycles:180 Average:4616.53 Median:5276.37 stddev:1344.97 (25.5%) stddev-sans-first:1309.57 19:06:04 INFO - PROCESS | 4171 | Values: 323.2 333.0 342.5 346.4 346.5 5237.8 5238.0 5315.4 5332.8 5382.5 5244.7 5262.3 5262.3 5269.9 5276.9 4160.3 4161.5 4176.1 4206.4 4238.8 3841.0 3944.3 4077.6 4103.9 4124.7 4079.4 4093.0 4096.9 4104.9 4109.3 4085.8 4097.0 4112.4 4128.6 4141.9 3441.2 3463.3 3625.0 3645.0 3653.8 5053.3 5066.3 5072.8 5074.9 5078.7 4694.1 4702.6 4723.6 4723.8 4741.1 5342.4 5391.4 5393.6 5429.0 5432.7 3984.8 4013.6 4014.0 4016.7 4030.8 5600.9 5605.5 5611.4 5612.5 5630.7 3931.3 4055.9 4059.3 4073.6 4093.8 4115.8 4152.5 4182.9 4183.6 4192.7 4683.0 4709.7 4722.1 4748.6 4754.5 5188.9 5443.0 5524.0 5539.4 5548.4 1397.8 1413.9 1415.7 1419.3 1424.1 884.3 909.2 918.4 926.0 933.6 4718.2 4737.0 4748.5 4753.6 5044.3 5458.1 5472.8 5563.2 5590.6 5607.9 5263.3 5275.9 5277.7 5284.9 5304.4 2846.5 2951.1 2951.9 2961.8 2968.5 5742.7 5747.1 5764.0 5774.2 5790.4 5628.7 5669.3 5715.9 5763.5 5773.2 5484.4 5763.4 5800.6 5815.4 5839.6 5615.6 5622.8 5641.6 5683.1 5765.2 5400.0 5558.8 5601.7 5661.6 5700.3 5823.5 5825.2 5837.8 5858.9 5867.5 4148.8 4180.3 4228.5 4228.9 4233.7 5471.8 5582.8 5594.0 5597.4 5695.1 5370.7 5450.9 5454.4 5454.9 5470.2 5414.2 5475.8 5495.8 5531.6 5551.6 5312.4 5413.9 5415.4 5418.2 5419.1 5264.7 5493.8 5508.8 5526.6 5562.4 5196.7 5284.2 5395.6 5398.5 5405.5 19:06:04 INFO - PROCESS | 4171 | 19:06:04 INFO - PROCESS | 4171 | [#5] yui.html Cycles:180 Average:20592.69 Median:4336.44 stddev:31075.42 (716.6%) stddev-sans-first:31126.59 19:06:04 INFO - PROCESS | 4171 | Values: 669.8 683.8 707.2 715.7 723.8 14093.5 15423.0 15431.0 15438.9 15506.1 12742.5 12783.4 12791.7 12839.9 12949.0 640.1 658.1 764.1 767.5 785.7 779.5 795.2 796.5 796.7 797.7 828.6 833.6 834.4 834.4 834.5 655.0 677.0 796.9 831.8 832.2 592.7 594.0 594.8 596.5 596.8 12943.6 12973.9 12977.6 12992.7 13032.9 12425.3 12629.9 12663.7 12960.9 13238.3 11968.8 12139.2 12180.9 12251.8 12448.2 4292.4 4335.7 4337.1 4412.4 4442.1 69394.3 74630.6 74988.0 75953.0 78648.0 10379.7 10565.5 10653.6 10831.4 11107.0 19925.1 19938.9 19966.4 20032.2 20246.8 7770.3 7777.7 7869.8 7941.5 7995.4 4270.3 4394.1 4417.4 4432.3 4456.3 3409.4 3462.1 3487.6 3488.3 3496.8 616.8 617.7 630.1 641.2 646.1 586.2 595.1 599.7 602.4 610.0 7934.2 8267.8 8354.8 8386.9 8585.3 564.8 566.7 587.6 587.7 615.9 3939.6 4052.8 4075.7 4078.1 4129.4 119214.4 120800.3 122563.0 122717.0 123346.0 66913.7 104759.0 105231.5 107935.5 112603.0 77674.0 93010.5 94547.5 94626.0 94806.2 8580.9 8768.1 8949.5 9072.4 9088.2 49161.8 50130.0 50461.7 51130.2 51208.0 69664.3 73019.6 76575.6 78801.0 78973.2 10911.0 10940.9 10987.6 11089.4 11288.9 12366.6 12419.6 12975.5 14543.6 14559.6 12226.4 12777.1 12903.5 12988.7 12995.6 12434.6 12527.8 12601.1 12947.0 12972.2 12288.4 12421.4 12893.7 13044.8 13397.3 10376.3 11029.6 11152.4 11289.2 11435.2 9286.3 10805.2 10945.7 11006.2 11059.4 19:06:04 INFO - PROCESS | 4171 | -------- Summary: end -------- 19:06:04 INFO - PROCESS | 4171 | 19:06:05 INFO - TEST-INFO | 4171: exit 0 19:06:05 INFO - TEST-OK | dromaeo_css | took 1118059ms 19:06:05 INFO - TEST-START | kraken 19:06:05 INFO - operating with platform_type : linux_ 19:06:05 INFO - Initialising browser for kraken test... 19:06:05 INFO - TEST-INFO | started process 4475 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUnA1Vt/profile http://localhost:54473/getInfo.html) 19:06:10 INFO - PROCESS | 4475 | __metrics Screen width/height:1600/1200 19:06:10 INFO - PROCESS | 4475 | colorDepth:24 19:06:10 INFO - PROCESS | 4475 | Browser inner width/height: 1024/697 19:06:10 INFO - PROCESS | 4475 | __metrics 19:06:10 INFO - PROCESS | 4475 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:06:10 INFO - PROCESS | 4475 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:06:11 INFO - PROCESS | 4475 | console.error: PushService: 19:06:11 INFO - PROCESS | 4475 | stateChangeProcessEnqueue: Error transitioning state 19:06:11 INFO - PROCESS | 4475 | UnknownError 19:06:12 INFO - TEST-INFO | 4475: exit 0 19:06:12 INFO - Browser initialized. 19:06:12 INFO - Running cycle 1/1 for kraken test... 19:06:12 INFO - TEST-INFO | started process 4557 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUnA1Vt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:06:24 INFO - PROCESS | 4557 | RSS: Main: 173867008 19:06:24 INFO - PROCESS | 4557 | 19:06:26 INFO - PROCESS | 4557 | Cycle 1(1): loaded http://localhost:54473/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54473/tests/kraken/driver.html?testName=audio-beat-detection) 19:06:27 INFO - PROCESS | 4557 | RSS: Main: 232767488 19:06:27 INFO - PROCESS | 4557 | 19:06:30 INFO - PROCESS | 4557 | Cycle 1(1): loaded http://localhost:54473/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54473/tests/kraken/driver.html?testName=audio-dft) 19:06:30 INFO - PROCESS | 4557 | RSS: Main: 217370624 19:06:30 INFO - PROCESS | 4557 | 19:06:34 INFO - PROCESS | 4557 | Cycle 1(1): loaded http://localhost:54473/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54473/tests/kraken/driver.html?testName=audio-fft) 19:06:34 INFO - PROCESS | 4557 | RSS: Main: 298377216 19:06:34 INFO - PROCESS | 4557 | 19:06:36 INFO - PROCESS | 4557 | Cycle 1(1): loaded http://localhost:54473/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54473/tests/kraken/driver.html?testName=audio-oscillator) 19:06:37 INFO - PROCESS | 4557 | RSS: Main: 208285696 19:06:37 INFO - PROCESS | 4557 | 19:06:39 INFO - PROCESS | 4557 | Cycle 1(1): loaded http://localhost:54473/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54473/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:06:40 INFO - PROCESS | 4557 | RSS: Main: 212750336 19:06:40 INFO - PROCESS | 4557 | 19:06:43 INFO - PROCESS | 4557 | Cycle 1(1): loaded http://localhost:54473/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54473/tests/kraken/driver.html?testName=imaging-darkroom) 19:06:43 INFO - PROCESS | 4557 | RSS: Main: 249069568 19:06:43 INFO - PROCESS | 4557 | 19:06:47 INFO - PROCESS | 4557 | Cycle 1(1): loaded http://localhost:54473/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54473/tests/kraken/driver.html?testName=imaging-desaturate) 19:06:47 INFO - PROCESS | 4557 | RSS: Main: 248004608 19:06:47 INFO - PROCESS | 4557 | 19:06:50 INFO - PROCESS | 4557 | Cycle 1(1): loaded http://localhost:54473/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54473/tests/kraken/driver.html?testName=json-parse-financial) 19:06:51 INFO - PROCESS | 4557 | RSS: Main: 248074240 19:06:51 INFO - PROCESS | 4557 | 19:06:52 INFO - PROCESS | 4557 | Cycle 1(1): loaded http://localhost:54473/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54473/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:06:53 INFO - PROCESS | 4557 | RSS: Main: 210481152 19:06:53 INFO - PROCESS | 4557 | 19:06:54 INFO - PROCESS | 4557 | Cycle 1(1): loaded http://localhost:54473/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54473/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:06:55 INFO - PROCESS | 4557 | RSS: Main: 218066944 19:06:55 INFO - PROCESS | 4557 | 19:06:57 INFO - PROCESS | 4557 | Cycle 1(1): loaded http://localhost:54473/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54473/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:06:58 INFO - PROCESS | 4557 | RSS: Main: 222605312 19:06:58 INFO - PROCESS | 4557 | 19:07:01 INFO - PROCESS | 4557 | Cycle 1(1): loaded http://localhost:54473/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54473/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:07:01 INFO - PROCESS | 4557 | RSS: Main: 223764480 19:07:01 INFO - PROCESS | 4557 | 19:07:04 INFO - PROCESS | 4557 | Cycle 1(1): loaded http://localhost:54473/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54473/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:07:05 INFO - PROCESS | 4557 | RSS: Main: 222126080 19:07:05 INFO - PROCESS | 4557 | 19:07:06 INFO - PROCESS | 4557 | Cycle 1(1): loaded http://localhost:54473/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54473/tests/kraken/driver.html?testName=ai-astar) 19:07:06 INFO - PROCESS | 4557 | RSS: Main: 274022400 19:07:06 INFO - PROCESS | 4557 | 19:07:06 INFO - PROCESS | 4557 | __start_tp_report 19:07:06 INFO - PROCESS | 4557 | _x_x_mozilla_page_load 19:07:06 INFO - PROCESS | 4557 | _x_x_mozilla_page_load_details 19:07:06 INFO - PROCESS | 4557 | |i|pagename|runs| 19:07:06 INFO - PROCESS | 4557 | |0;ai-astar;109;111;110;110;112;111;111;110;109;111 19:07:06 INFO - PROCESS | 4557 | |1;audio-beat-detection;158;126;127;158;122;124;124;122;152;122 19:07:06 INFO - PROCESS | 4557 | |2;audio-dft;162;162;162;163;160;162;161;161;160;162 19:07:06 INFO - PROCESS | 4557 | |3;audio-fft;76;75;76;110;76;76;76;75;106;76 19:07:06 INFO - PROCESS | 4557 | |4;audio-oscillator;82;84;114;82;84;84;103;84;82;110 19:07:06 INFO - PROCESS | 4557 | |5;imaging-gaussian-blur;117;117;116;116;117;118;117;117;117;117 19:07:06 INFO - PROCESS | 4557 | |6;imaging-darkroom;146;145;146;145;145;145;146;145;146;145 19:07:06 INFO - PROCESS | 4557 | |7;imaging-desaturate;95;95;95;94;95;95;94;94;95;95 19:07:06 INFO - PROCESS | 4557 | |8;json-parse-financial;53;51;50;51;52;52;52;50;52;52 19:07:06 INFO - PROCESS | 4557 | |9;json-stringify-tinderbox;62;61;61;61;62;62;65;61;62;62 19:07:06 INFO - PROCESS | 4557 | |10;stanford-crypto-aes;80;81;89;83;80;87;80;80;80;78 19:07:06 INFO - PROCESS | 4557 | |11;stanford-crypto-ccm;140;135;129;145;127;138;141;138;168;128 19:07:06 INFO - PROCESS | 4557 | |12;stanford-crypto-pbkdf2;163;168;167;164;165;164;164;167;165;165 19:07:06 INFO - PROCESS | 4557 | |13;stanford-crypto-sha256-iterative;72;65;67;65;65;65;64;65;63;66 19:07:06 INFO - PROCESS | 4557 | __end_tp_report 19:07:06 INFO - PROCESS | 4557 | __start_cc_report 19:07:06 INFO - PROCESS | 4557 | _x_x_mozilla_cycle_collect,1645 19:07:06 INFO - PROCESS | 4557 | __end_cc_report 19:07:06 INFO - PROCESS | 4557 | __startTimestamp1475374026968__endTimestamp 19:07:06 INFO - PROCESS | 4557 | 19:07:06 INFO - PROCESS | 4557 | ------- Summary: start ------- 19:07:06 INFO - PROCESS | 4557 | Number of tests: 14 19:07:06 INFO - PROCESS | 4557 | 19:07:06 INFO - PROCESS | 4557 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:0.97 (0.9%) stddev-sans-first:0.88 19:07:06 INFO - PROCESS | 4557 | Values: 109.0 111.0 110.0 110.0 112.0 111.0 111.0 110.0 109.0 111.0 19:07:06 INFO - PROCESS | 4557 | 19:07:06 INFO - PROCESS | 4557 | [#1] audio-beat-detection Cycles:10 Average:133.50 Median:126.50 stddev:15.70 (12.4%) stddev-sans-first:13.93 19:07:06 INFO - PROCESS | 4557 | Values: 158.0 126.0 127.0 158.0 122.0 124.0 124.0 122.0 152.0 122.0 19:07:06 INFO - PROCESS | 4557 | 19:07:06 INFO - PROCESS | 4557 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 19:07:06 INFO - PROCESS | 4557 | Values: 162.0 162.0 162.0 163.0 160.0 162.0 161.0 161.0 160.0 162.0 19:07:06 INFO - PROCESS | 4557 | 19:07:06 INFO - PROCESS | 4557 | [#3] audio-fft Cycles:10 Average:82.20 Median:76.00 stddev:13.64 (17.9%) stddev-sans-first:14.28 19:07:06 INFO - PROCESS | 4557 | Values: 76.0 75.0 76.0 110.0 76.0 76.0 76.0 75.0 106.0 76.0 19:07:06 INFO - PROCESS | 4557 | 19:07:06 INFO - PROCESS | 4557 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:83.00 stddev:12.79 (15.4%) stddev-sans-first:13.16 19:07:06 INFO - PROCESS | 4557 | Values: 82.0 84.0 114.0 82.0 84.0 84.0 103.0 84.0 82.0 110.0 19:07:06 INFO - PROCESS | 4557 | 19:07:06 INFO - PROCESS | 4557 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 19:07:06 INFO - PROCESS | 4557 | Values: 117.0 117.0 116.0 116.0 117.0 118.0 117.0 117.0 117.0 117.0 19:07:06 INFO - PROCESS | 4557 | 19:07:06 INFO - PROCESS | 4557 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 19:07:06 INFO - PROCESS | 4557 | Values: 146.0 145.0 146.0 145.0 145.0 145.0 146.0 145.0 146.0 145.0 19:07:06 INFO - PROCESS | 4557 | 19:07:06 INFO - PROCESS | 4557 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 19:07:06 INFO - PROCESS | 4557 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 94.0 94.0 95.0 95.0 19:07:06 INFO - PROCESS | 4557 | 19:07:06 INFO - PROCESS | 4557 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:52.00 stddev:0.97 (1.9%) stddev-sans-first:0.87 19:07:06 INFO - PROCESS | 4557 | Values: 53.0 51.0 50.0 51.0 52.0 52.0 52.0 50.0 52.0 52.0 19:07:06 INFO - PROCESS | 4557 | 19:07:06 INFO - PROCESS | 4557 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:1.20 (1.9%) stddev-sans-first:1.27 19:07:06 INFO - PROCESS | 4557 | Values: 62.0 61.0 61.0 61.0 62.0 62.0 65.0 61.0 62.0 62.0 19:07:06 INFO - PROCESS | 4557 | 19:07:06 INFO - PROCESS | 4557 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:80.50 stddev:3.52 (4.4%) stddev-sans-first:3.67 19:07:06 INFO - PROCESS | 4557 | Values: 80.0 81.0 89.0 83.0 80.0 87.0 80.0 80.0 80.0 78.0 19:07:06 INFO - PROCESS | 4557 | 19:07:06 INFO - PROCESS | 4557 | [#11] stanford-crypto-ccm Cycles:10 Average:138.90 Median:139.00 stddev:11.86 (8.5%) stddev-sans-first:12.57 19:07:06 INFO - PROCESS | 4557 | Values: 140.0 135.0 129.0 145.0 127.0 138.0 141.0 138.0 168.0 128.0 19:07:06 INFO - PROCESS | 4557 | 19:07:06 INFO - PROCESS | 4557 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.20 Median:165.00 stddev:1.62 (1.0%) stddev-sans-first:1.51 19:07:06 INFO - PROCESS | 4557 | Values: 163.0 168.0 167.0 164.0 165.0 164.0 164.0 167.0 165.0 165.0 19:07:06 INFO - PROCESS | 4557 | 19:07:06 INFO - PROCESS | 4557 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:65.00 stddev:2.45 (3.8%) stddev-sans-first:1.12 19:07:06 INFO - PROCESS | 4557 | Values: 72.0 65.0 67.0 65.0 65.0 65.0 64.0 65.0 63.0 66.0 19:07:06 INFO - PROCESS | 4557 | -------- Summary: end -------- 19:07:06 INFO - PROCESS | 4557 | 19:07:08 INFO - TEST-INFO | 4557: exit 0 19:07:08 INFO - TEST-OK | kraken | took 62949ms 19:07:08 INFO - SUITE-END | took 1181s 19:07:08 INFO - Completed test suite (00:19:41) 19:07:08 INFO - javascript benchmark 19:07:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2955.4827905116604, 3005.053408176425, 3009.774266929981, 3033.120395085425, 3054.786164968452, 5227.634065615409, 5269.76286067127, 5306.89386212276, 5412.107002344614, 5426.186072089184, 5324.494173053564, 5328.813491527797, 5337.359516857973, 5353.411124776271, 5362.678239305645, 4804.087223427555, 4826.951730482703, 4900.215965445529, 4901.828436004741, 4930.03864246472, 4817.614590832725, 4855.368802055727, 4887.2913427552985, 4927.876803079916, 4997.125503036972, 4796.44840843304, 4902.632302577304, 4925.285833554132, 4938.407391113072, 4983.9252411213865, 4865.854024379274, 4913.803447862099, 4919.385076865392, 4943.752812359367, 4966.304717339575, 4704.1767690654, 4738.786754596052, 4758.547937945889, 4787.329773831666, 4822.180229361017, 5268.209768534751, 5279.445658205871, 5286.867828304285, 5345.786168553253, 5373.838784836461, 5629.071203251458, 5671.092625179951, 5673.404292549264, 5692.260006199209, 5693.373728889819, 5510.1459273812625, 5535.529479994206, 5650.237217975603, 5704.402767225183, 5775.711214439303, 5338.199270109515, 5338.599605029638, 5356.0626890294825, 5393.703346315951, 5402.594805389572, 5808.79669211584, 5814.040683287295, 5818.912716309259, 5819.6508209507565, 5822.737976791054, 5422.43064478232, 5476.288082549323, 5582.106862901916, 5602.13166959122, 5605.607607467438, 5608.0, 5689.118186681071, 5700.857478562986, 5720.1991721159075, 5789.0, 5648.604597678205, 5656.0, 5689.0328644130595, 5701.315842098975, 5701.857453563694, 5486.067368547357, 5715.31416230055, 5728.398518155617, 5731.197632331477, 5779.826605201851, 4320.200762858881, 4354.433923589913, 4361.498427680857, 4364.803583838735, 4372.715773474714, 3858.305505009125, 3862.8261728222296, 3863.8068096595057, 3906.4921560196995, 3906.8865373368453, 5373.817760092773, 5374.838754837283, 5376.38171610262, 5376.838694839161, 5424.240606315119, 5482.342118945752, 5529.419410961871, 5537.723113844291, 5615.101583746581, 5700.8859822803315, 5243.475652434802, 5311.044012077863, 5312.654677446031, 5314.548263397577, 5321.441248668912, 4854.271859221074, 4880.438749543777, 4897.216445368796, 4897.804087836446, 4899.2896030075435, 5784.4504772046585, 5792.681402522901, 5800.622959507703, 5810.157527158538, 5814.476697097197, 5602.523785478117, 5605.495505404533, 5620.775168993358, 5622.409646987007, 5626.493615574618, 5798.5651076168615, 5799.594028417971, 5802.0, 5802.5357971361345, 5802.564807639359, 5459.235707001102, 5467.535259502987, 5548.722563871871, 5558.305211848519, 5576.470235327637, 5724.169995350568, 5731.111677689964, 5734.369219385948, 5738.856528586652, 5739.253896993364, 5319.760610772602, 5413.56691464674, 5581.804636837691, 5590.748416321194, 5593.272874526286, 5435.2934118564335, 5503.284573005483, 5510.338759348904, 5535.667859928256, 5597.748101335531, 5481.5340696041285, 5483.122700367922, 5484.204790305464, 5484.287042684426, 5486.972565137149, 5413.648112872651, 5447.645903016291, 5569.66582005081, 5591.161325801162, 5591.748371323219, 5499.120140777456, 5547.362053363915, 5583.0, 5589.748461319169, 5590.0], "value": 5229.118283548222, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.601603755134, 588.5174157191102, 592.218271881117, 594.8037147741246, 610.0391882784614, 31148.844255778717, 41863.581364186386, 42221.57778422215, 42227.577724222785, 42298.924129104475, 43717.12565748683, 44202.0, 44286.0, 44290.0, 44315.33526997089, 8118.431709780318, 8882.777930551756, 9045.3668243223, 9054.4114632549, 9058.592363343665, 8092.635831387573, 10485.213608979318, 10740.516676749565, 10741.731456713605, 11145.21983461158, 10911.618093366733, 10971.23201375904, 10976.341419514814, 10978.560857565688, 10979.2863463875, 10747.570097196103, 10811.945940270249, 10813.945930270338, 10828.72928176794, 10834.295770774874, 10626.468676566217, 10696.78606427867, 10699.0, 10701.09040731531, 10702.839457408145, 42580.78709606432, 42875.57124428747, 42916.57083429188, 42927.78536107331, 42947.35578966318, 3495.528103706018, 3521.418965870628, 3631.636836316374, 3642.488367327556, 4107.486564179478, 31546.369072618418, 31907.84046079778, 31945.52081718776, 32044.359112817845, 32463.83768081168, 4202.117555313357, 4274.914501709948, 4321.330193819931, 4399.5380485049245, 4462.12988467249, 324982.0, 325852.0, 326261.0, 326969.0, 328417.0, 34365.65634343675, 56683.0, 57086.42913570811, 57104.42895571074, 57161.0, 35192.64807351894, 37339.81330093386, 37456.43815342772, 37567.81216093902, 37576.24847503035, 15880.60298492547, 16011.679766404606, 16026.11856347912, 16032.599185020235, 16032.919835400748, 11847.466863991142, 12302.261864288172, 13053.804192937114, 13410.195388276734, 13496.797548036788, 8436.535990520457, 8442.662293508314, 8501.489910605384, 8620.612072456754, 8624.525651089125, 3251.3009702913987, 3294.5387645729616, 3314.6022477302395, 3325.384803811254, 3361.647027062172, 997.152420442618, 1009.3590569988111, 1077.21363404715, 1129.1869853705318, 1151.090638395675, 31131.042550957623, 31267.374652506824, 31319.0, 31370.14437265719, 31457.21356966094, 1058.523664351045, 1076.612419528969, 1114.164376717462, 1120.523777394604, 1182.0779791762438, 16264.75602865958, 16724.331026759035, 16934.49196524106, 16940.83059169417, 17140.0, 505045.0, 506865.0, 508051.0, 509204.0, 511725.0, 57665.423345766845, 57694.423055769745, 58233.70883145642, 58273.0, 58344.70827645835, 1203.2720204276286, 1218.2933898338943, 1240.925544467335, 1351.9324033798468, 1354.573309407553, 30375.24061898382, 31770.841145794122, 32519.512207316435, 32831.83584082064, 33523.329533409684, 48680.5131948676, 49506.0, 49971.75014124906, 50007.74996124996, 50013.99972000467, 392007.0, 392562.0, 392858.0, 393239.0, 393533.0, 27500.862495687394, 28500.57249141306, 28581.28546786264, 29734.702652974058, 30021.399572008002, 46729.76635116803, 47094.52905470901, 47099.764501178644, 47229.2915606273, 49494.75252623714, 39733.0, 40223.396649050876, 40812.59187408088, 41049.79475102725, 42628.78685606552, 38968.647524593325, 39126.0, 39427.0, 40779.38830917479, 41274.0, 38881.805590972996, 39990.40014399844, 40850.38724419195, 40999.38500922429, 41009.589904100576, 31044.379112418075, 34872.82563587166, 35996.64003359933, 38357.61642383652, 38620.227595448494, 27709.0, 27852.72147278501, 27885.860570697827, 28098.87604495797, 28128.43743125085], "value": 19085.79823319224, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.96371344722274, 396.8531643291981, 401.6425381410545, 409.5188153919145, 426.4520091682189, 13257.33713314334, 15346.69306613867, 19039.61920761584, 19120.904395478003, 19787.109580068896, 18503.814961850378, 18868.245270189174, 18996.525086872836, 19020.714689279674, 19394.51513712158, 5512.090505066679, 5694.886102277952, 5935.465808077272, 5944.464998150165, 5949.762009519614, 5679.886402271952, 5856.267966504187, 5857.326407463132, 5859.326177489601, 5861.618994765348, 3740.6446387593273, 3965.385365268388, 5651.378348381675, 5878.88242235155, 5922.703864806743, 5770.538356931435, 5879.412058794129, 6008.098785182214, 6013.909791353133, 6021.397860213965, 5606.439356064361, 5636.070048442002, 5641.238432811559, 5643.097104463266, 5647.661140331593, 13544.525941591997, 13650.93174534131, 13779.966502512352, 14785.926070369687, 21996.780032199633, 2228.0864845413466, 2248.2580748353002, 2309.261036468331, 2427.7693619106158, 2835.9858200708863, 10095.798084038279, 10296.691099267035, 12123.636290911287, 14031.78952315716, 14049.578512644637, 1854.3695143651223, 1881.2264722533978, 1884.2839720905968, 1889.3765057530982, 1979.8218160365493, 72335.27664723338, 74371.99999999946, 76348.61825690836, 79230.0, 79594.0, 10568.471576421149, 10647.787044259072, 10700.30448020876, 10787.514561844579, 11171.888281117248, 15652.0, 15668.294926728324, 15692.843071569137, 15707.957965464417, 15717.528474145794, 7708.421868359896, 7937.642806073741, 7985.241402066795, 8307.418480706414, 8317.334613230927, 7714.961425192838, 7740.574268415291, 7761.107472640606, 7964.6415911282975, 7987.041555013436, 4567.109413664303, 4583.977080114578, 4607.101615185007, 4643.744594047293, 4798.0, 1918.3765276285262, 1919.1459800388693, 1952.687569988795, 1967.3114409956686, 1974.0524548216936, 864.8832407625016, 934.4019827310527, 939.1266122505998, 939.7039932421266, 986.1765425869336, 17475.456381340944, 18751.24995000212, 19079.80920190808, 19256.70612917734, 19440.0, 945.0360632155164, 955.302629080775, 974.3617930255693, 984.227381505529, 991.7818080022528, 9979.50102494887, 10686.0, 10801.83797243042, 10850.403227822546, 10897.0, 468089.0, 473315.0, 476340.0, 483497.0, 483783.0, 62404.68797655983, 84287.57856210679, 84729.57635211785, 85000.57499712461, 88212.5589372049, 952.6618050592078, 959.7504648791364, 992.8014397120605, 998.2762497189625, 1003.9096481316717, 16011.0, 16527.83472165263, 16980.0, 17000.65998680044, 17315.826841731927, 39672.0, 39950.200995979336, 40045.0, 40390.52775236591, 41007.58992410038, 49882.75058624829, 52070.0, 52377.7381113092, 52545.0, 54128.0, 8437.535935523605, 11332.093432525213, 11518.424078795859, 12005.650422533721, 12412.62762117138, 13329.733405331644, 13499.797503037658, 13655.658608534468, 14131.505397311044, 14341.92829035848, 12050.457729402022, 12082.577109801467, 12299.877001229874, 12439.0, 12532.49870005226, 12068.818967715666, 12119.75760484803, 12165.0, 12189.329586872453, 12508.687282817638, 6110.816675499742, 8077.919220807717, 11089.780124186173, 11756.447276709941, 12175.878241217828, 12208.084393670333, 12235.816462752888, 12240.755184896074, 12409.751804964031, 12613.117081804186, 11994.820077698667, 12276.202046867282, 12330.260184388966, 12617.0, 12719.173253738478], "value": 9146.066808797259, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1315.7828958221894, 1412.4041618313647, 1444.761614333635, 1556.6419723463603, 1716.9399071032508, 7789.8831517527215, 8850.91149088509, 9192.770180745485, 9199.816003679922, 9539.09378609031, 9296.488693121875, 9376.343655944069, 9383.671571494999, 9384.8592271116, 9394.483303418308, 2344.6834677318598, 2353.670486131943, 2371.9644205336936, 2375.406148462884, 2381.4879800842814, 2295.8163346932206, 2310.445493081657, 2374.3114496795906, 2378.9048438062455, 2383.940401489959, 2321.7562155973633, 2323.6282194848827, 2343.8593684378907, 2363.09021026905, 2365.042157926043, 2243.596152692515, 2245.6070187717246, 2283.6460348645905, 2288.2906299047268, 2294.529621427612, 2293.1629955066446, 2295.540891821642, 2296.552172326397, 2303.7465878753324, 2304.0783686525524, 9274.860877086849, 9336.859947100798, 9337.253019758471, 9341.065893410672, 9476.810463790755, 5461.535769459561, 5569.805056823032, 5572.832815015556, 5585.832425027255, 5589.832305030855, 3443.6900678938764, 3465.081753335368, 3475.461303497962, 3489.91275218119, 3529.6293889141784, 1141.7545227776068, 1169.4152923538231, 1178.2047118195185, 1183.3905538647518, 1189.9821502677466, 12946.741065178643, 13171.670708232276, 13238.53665121716, 13248.20510769357, 13266.40301186449, 4406.25093734066, 4514.413126293561, 4702.130105930414, 4709.811607535728, 4713.175194340976, 9880.061394167542, 9889.258305626963, 9895.60417583303, 9897.01029897019, 9906.356086854332, 5478.041342765, 5489.58828087887, 5491.9725401373535, 5494.0, 5496.065668836308, 4506.459224892968, 4650.255959046604, 4926.236433352764, 5023.34696489454, 5131.1277082895995, 3766.1902690921584, 3791.241751649681, 3893.824777885002, 3894.4742459768136, 3901.1612503311926, 1102.0, 1126.1722633864267, 1128.328644456547, 1128.887111288881, 1144.0618692672097, 694.4999600287784, 819.8319344534356, 852.1946760311446, 905.4160066756905, 915.0163574157807, 5583.692896890629, 5656.5757568181725, 5782.855428614234, 5930.140129681172, 6079.513638908877, 405.6997821612045, 411.7611785164597, 413.6566649680758, 430.55222568529007, 441.1750027448692, 3745.513083299208, 3804.771713697187, 3822.445745366906, 3854.8265328060306, 4012.799360031987, 11383.829242561369, 11683.182177247681, 11906.583269585522, 11916.225445346025, 11917.22538035025, 11402.828957565644, 11498.827517587242, 11700.180987330976, 11840.822387664191, 11873.940630296966, 8522.573871306535, 8581.442206256574, 8639.352048596254, 8651.0, 8651.567421629019, 5674.744636491285, 5749.367569567428, 5780.248567686174, 5806.390329015392, 5992.520598352208, 10477.16182705397, 10763.300385474919, 10876.075533579735, 10932.890671093188, 10945.343279403261, 11100.833487497855, 11110.722231944266, 11128.109751219721, 11134.220604557604, 11135.0, 6804.4556435484055, 6884.724611015704, 7335.083114610674, 7810.179931107152, 7846.293833555007, 8985.281177505914, 9079.68221112258, 9115.270778337584, 9162.816743665222, 9188.127127922837, 7759.72840950564, 8020.117787043538, 8105.716299929474, 8240.258376746122, 8329.625166867385, 7759.495632783851, 7880.960595196987, 7928.603569821601, 7982.6008699565955, 8020.919790802017, 7056.6118863463, 7095.113110861143, 7177.2463891292755, 7182.676779545038, 7188.676509557187, 4928.802847886188, 5063.87340316495, 5096.286519887293, 5264.420913699567, 5448.863778405572, 4893.975530122327, 4912.45962944083, 5120.385553733576, 5220.869478263074, 5366.892662146657], "value": 4586.311028875151, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.16761121325277, 332.99269709129885, 342.477721474751, 346.3713360251145, 346.50622862421045, 5237.790488380465, 5238.0, 5315.36215654121, 5332.760025798839, 5382.515573598375, 5244.711540865251, 5262.2632831403635, 5262.342207224097, 5269.86825329367, 5276.868078298045, 4160.251154792136, 4161.542230354658, 4176.102138040321, 4206.41110244566, 4238.766867822269, 3840.9807950960208, 3944.3294639911283, 4077.5922407759285, 4103.897402564945, 4124.690648201382, 4079.388091786241, 4093.0, 4096.85661001865, 4104.897377565555, 4109.301418758818, 4085.836566537335, 4096.97951510242, 4112.444819949298, 4128.60778226068, 4141.855035073788, 3441.1913200397885, 3463.3246516928957, 3624.963750362489, 3644.9976256529403, 3653.762505437138, 5053.267276244961, 5066.265391518246, 5072.771725272371, 5074.923876141861, 5078.695278283315, 4694.08465349257, 4702.553257440538, 4723.645726570521, 4723.787429565644, 4741.146593613148, 5342.435630897152, 5391.406945236021, 5393.568514518829, 5428.972855135738, 5432.70120143392, 3984.7609143451486, 4013.618706222904, 4013.979930100331, 4016.6786657067364, 4030.7984600769846, 5600.915986260209, 5605.467480589337, 5611.438856114356, 5612.466815652507, 5630.746616402272, 3931.312020396419, 4055.9391609125887, 4059.2693315203546, 4073.551909289976, 4093.7543747375253, 4115.794210289474, 4152.480939882515, 4182.937255941163, 4183.560726123774, 4192.685548583869, 4682.979478236586, 4709.670323077352, 4722.126406614787, 4748.596369308648, 4754.478566858572, 5188.948110518922, 5442.972785136049, 5523.972380138073, 5539.362973258047, 5548.445155484419, 1397.7833435817465, 1413.9151650900978, 1415.6814716688662, 1419.2974477633638, 1424.1099312929418, 884.2969838978028, 909.2362415570952, 918.4168053286078, 925.9768505787274, 933.6125507914139, 4718.2214934536105, 4736.9578692687555, 4748.525147485224, 4753.619710423158, 5044.268581055726, 5458.072127738294, 5472.808451704172, 5563.248961390242, 5590.580706446952, 5607.8598035048635, 5263.34208223972, 5275.86568887691, 5277.736113194325, 5284.867878303073, 5304.363476382859, 2846.51609226432, 2951.070412819955, 2951.8671659775364, 2961.7926745128066, 2968.539876319174, 5742.712864356766, 5747.051736463437, 5764.0, 5774.220480235114, 5790.420957904176, 5628.662280263197, 5669.348024977098, 5715.942840571624, 5763.538916886723, 5773.191753154561, 5484.396716361197, 5763.36602973681, 5800.622959507618, 5815.389384114607, 5839.649621022667, 5615.613364320066, 5622.7750889963945, 5641.633293835887, 5683.090705487102, 5765.164051212634, 5400.0, 5558.805441809517, 5601.747921343468, 5661.603687741983, 5700.287464066992, 5823.475887170175, 5825.2135961644635, 5837.795677151279, 5858.86151554688, 5867.5305975521005, 4148.8133034012935, 4180.310248808913, 4228.450301460791, 4228.915421691488, 4233.661307095486, 5471.79620483493, 5582.794796055617, 5593.972030139823, 5597.384287728265, 5695.1457281406465, 5370.704611246419, 5450.8909821802545, 5454.445483037315, 5454.918176227439, 5470.17947307907, 5414.174894921253, 5475.808346707846, 5495.752691128989, 5531.557475401878, 5551.641257039433, 5312.362516498045, 5413.945860541502, 5415.35015798091, 5418.214358917856, 5419.132938729785, 5264.710440925633, 5493.802479008428, 5508.779648814003, 5526.557875370041, 5562.443755624405, 5196.68819870809, 5284.233786100917, 5395.56835453155, 5398.514133727984, 5405.5135037846785], "value": 4188.742227582215, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.7856685860525, 683.7811900191938, 707.2220557386878, 715.7494876793123, 723.797336745711, 14093.506727264536, 15423.0, 15431.0, 15438.922805385986, 15506.14716190609, 12742.490300387997, 12783.424745886434, 12791.680207994805, 12839.871601283985, 12949.028822838301, 640.0559175216541, 658.1312667279169, 764.1059959846965, 767.5126294802812, 785.7367781793106, 779.4894344204555, 795.1730200591378, 796.4822865137678, 796.6693822063836, 797.6769408389612, 828.5732847583499, 833.6415341403194, 834.3533761334984, 834.3867257565685, 834.4909605140859, 654.9541532092732, 676.9796906092826, 796.8764841449585, 831.7920519870032, 832.21355818751, 592.7066102279356, 593.9524838012949, 594.8334466349429, 596.5049009322252, 596.8120042186697, 12943.611691649265, 12973.870261297361, 12977.610671679864, 12992.675183120404, 13032.86967130326, 12425.31660758667, 12629.87370126296, 12663.746725065539, 12960.935195324057, 13238.27189504577, 11968.82046769299, 12139.210951288227, 12180.939095304555, 12251.790082497262, 12448.190867593577, 4292.3992278643655, 4335.739855608674, 4337.132573485315, 4412.40432541606, 4442.133783912106, 69394.30605693928, 74630.62684686542, 74987.99999999946, 75953.0, 78648.0, 10379.688609341732, 10565.524551395205, 10653.573857045787, 10831.404272764916, 11107.0, 19925.10337034837, 19938.90030549838, 19966.401007969784, 20032.198712051646, 20246.797532024786, 7770.339521140653, 7777.688892444352, 7869.842603147905, 7941.483803552751, 7995.360371170293, 4270.316749320094, 4394.143142087262, 4417.425734654538, 4432.29083346663, 4456.286994080931, 3409.4374428219066, 3462.117160124152, 3487.5814902211896, 3488.319777643386, 3496.8251587420527, 616.7687117331001, 617.7065893700546, 630.0612087988864, 641.2433328672118, 646.0922404022356, 586.2115454713404, 595.1221947627301, 599.66718471248, 602.3765402808073, 609.9878002439926, 7934.1629071438965, 8267.8346433071, 8354.791130221793, 8386.916130838736, 8585.270252028522, 564.8390208790476, 566.6852901269099, 587.6474115530648, 587.7149582452507, 615.9322474527798, 3939.6060393960374, 4052.8378864845076, 4075.694322925792, 4078.1232035112, 4129.380592911088, 119214.4039279798, 120800.2756127642, 122563.0, 122717.0, 123346.0, 66913.66543167351, 104759.0, 105231.47384263182, 107935.46032269788, 112603.0, 77674.0, 93010.53494732484, 94547.52726236325, 94626.0, 94806.15581532565, 8580.91419085826, 8768.123187681182, 8949.507777072064, 9072.364934454525, 9088.182063614306, 49161.754191228814, 50130.0, 50461.747691261306, 51130.233046503585, 51208.0, 69664.30335696579, 73019.63490182515, 76575.61712191404, 78801.0, 78973.21026789659, 10911.0, 10940.890591093987, 10987.61543345979, 11089.445527723743, 11288.887111128784, 12366.567170149001, 12419.565315213924, 12975.480980760663, 14543.563693089225, 14559.563213103624, 12226.449809758404, 12777.105602607728, 12903.51337698219, 12988.675283117998, 12995.610131696065, 12434.564790232298, 12527.80020506524, 12601.054920880788, 12947.0, 12972.156809807333, 12288.447019883948, 12421.378931053592, 12893.677658058623, 13044.804327934899, 13397.330133493091, 10376.273660843668, 11029.558817647205, 11152.442377881236, 11289.20975531705, 11435.199536032398, 9286.34995550332, 10805.243632945618, 10945.726356841144, 11006.174536909604, 11059.447027648424], "value": 7125.463451387086, "unit": "score"}], "name": "dromaeo_css", "value": 7070.708214887577, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 110.0, 110.0, 112.0, 111.0, 111.0, 110.0, 109.0, 111.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 126.0, 127.0, 158.0, 122.0, 124.0, 124.0, 122.0, 152.0, 122.0], "value": 133.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 163.0, 160.0, 162.0, 161.0, 161.0, 160.0, 162.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 110.0, 76.0, 76.0, 76.0, 75.0, 106.0, 76.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 114.0, 82.0, 84.0, 84.0, 103.0, 84.0, 82.0, 110.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 50.0, 51.0, 52.0, 52.0, 52.0, 50.0, 52.0, 52.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 61.0, 62.0, 62.0, 65.0, 61.0, 62.0, 62.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 89.0, 83.0, 80.0, 87.0, 80.0, 80.0, 80.0, 78.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 135.0, 129.0, 145.0, 127.0, 138.0, 141.0, 138.0, 168.0, 128.0], "value": 138.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 168.0, 167.0, 164.0, 165.0, 164.0, 164.0, 167.0, 165.0, 165.0], "value": 165.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 65.0, 67.0, 65.0, 65.0, 65.0, 64.0, 65.0, 63.0, 66.0], "value": 65.7, "unit": "score"}], "name": "kraken", "value": 1500.5000000000002, "alertThreshold": 2.0}]} 19:07:08 INFO - Return code: 0 19:07:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:07:08 INFO - # TBPL SUCCESS # 19:07:08 INFO - Running post-action listener: _resource_record_post_action 19:07:08 INFO - [mozharness: 2016-10-02 02:07:08.771640Z] Finished run-tests step (success) 19:07:08 INFO - Running post-run listener: _resource_record_post_run 19:07:08 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392929280; Read time: 16; Write time: 586268 19:07:08 INFO - TinderboxPrint: CPU usage
13.1% 19:07:08 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 19:07:08 INFO - TinderboxPrint: I/O write bytes / time
392,929,280 / 586,268 19:07:08 INFO - TinderboxPrint: CPU idle
8,316.2 (86.9%) 19:07:08 INFO - TinderboxPrint: CPU user
1,197.9 (12.5%) 19:07:08 INFO - TinderboxPrint: Swap in / out
0 / 0 19:07:08 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 105230336; Read time: 0; Write time: 182032 19:07:08 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 287698944; Read time: 0; Write time: 404236 19:07:09 INFO - Running post-run listener: _upload_blobber_files 19:07:09 INFO - Blob upload gear active. 19:07:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:07:09 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 19:07:09 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:07:09 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:07:09 INFO - (blobuploader) - INFO - Open directory for files ... 19:07:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:07:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:07:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:07:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:07:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:07:13 INFO - (blobuploader) - INFO - Done attempting. 19:07:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:07:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:07:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:07:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:07:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:07:14 INFO - (blobuploader) - INFO - Done attempting. 19:07:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:07:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:07:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:07:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:07:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:07:14 INFO - (blobuploader) - INFO - Done attempting. 19:07:14 INFO - (blobuploader) - INFO - Iteration through files over. 19:07:14 INFO - Return code: 0 19:07:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:07:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:07:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5610df47838b4461dc04621876ad26d7e1ac9bf0e897cf2776eeed002dab781c9b2e4f92c640d242e83c1621f7122f06327fd50e84eb0d55c16bfc5708059110", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e5b04eeba5929b71a03aca405bba6040f96ee67b45c260acb0a1396f36af4d0a762acdeffc37738f2b44f593aabbcd3e58709fa87db00084c9e47fd854f6657a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9c3496151bbf9dffddca345f87c9ac90671de1b96a3c3a4c287519fbaf376f91b5fa6106a0bc237a07047da285c72708a2c9ec679070290a2c4555ae7f9118dc"} 19:07:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:07:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:07:14 INFO - Contents: 19:07:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5610df47838b4461dc04621876ad26d7e1ac9bf0e897cf2776eeed002dab781c9b2e4f92c640d242e83c1621f7122f06327fd50e84eb0d55c16bfc5708059110", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e5b04eeba5929b71a03aca405bba6040f96ee67b45c260acb0a1396f36af4d0a762acdeffc37738f2b44f593aabbcd3e58709fa87db00084c9e47fd854f6657a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9c3496151bbf9dffddca345f87c9ac90671de1b96a3c3a4c287519fbaf376f91b5fa6106a0bc237a07047da285c72708a2c9ec679070290a2c4555ae7f9118dc"} 19:07:14 INFO - Running post-run listener: copy_logs_to_upload_dir 19:07:14 INFO - Copying logs to upload dir... 19:07:14 INFO - mkdir: /builds/slave/test/build/upload/logs 19:07:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.829620 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-10-01 19:07:14.052922) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-01 19:07:14.056029) ========= 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=745a4373a2a16df560f216e000000264-1475372789.598508-952381448 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5610df47838b4461dc04621876ad26d7e1ac9bf0e897cf2776eeed002dab781c9b2e4f92c640d242e83c1621f7122f06327fd50e84eb0d55c16bfc5708059110", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e5b04eeba5929b71a03aca405bba6040f96ee67b45c260acb0a1396f36af4d0a762acdeffc37738f2b44f593aabbcd3e58709fa87db00084c9e47fd854f6657a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9c3496151bbf9dffddca345f87c9ac90671de1b96a3c3a4c287519fbaf376f91b5fa6106a0bc237a07047da285c72708a2c9ec679070290a2c4555ae7f9118dc"} build_url:https://queue.taskcluster.net/v1/task/fXj3d8e1Rc2-6D01XTVuqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011312 build_url: 'https://queue.taskcluster.net/v1/task/fXj3d8e1Rc2-6D01XTVuqg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5610df47838b4461dc04621876ad26d7e1ac9bf0e897cf2776eeed002dab781c9b2e4f92c640d242e83c1621f7122f06327fd50e84eb0d55c16bfc5708059110", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e5b04eeba5929b71a03aca405bba6040f96ee67b45c260acb0a1396f36af4d0a762acdeffc37738f2b44f593aabbcd3e58709fa87db00084c9e47fd854f6657a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9c3496151bbf9dffddca345f87c9ac90671de1b96a3c3a4c287519fbaf376f91b5fa6106a0bc237a07047da285c72708a2c9ec679070290a2c4555ae7f9118dc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-01 19:07:14.081192) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 19:07:14.081498) ========= 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=745a4373a2a16df560f216e000000264-1475372789.598508-952381448 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004465 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 19:07:14.167706) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-01 19:07:14.168013) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-01 19:07:14.168310) ========= ========= Total master_lag: 0.18 =========